-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2025-05-09 17:50:36 CEST. -- May 09 17:49:22 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken May 09 17:49:22 vol-office volumio[967]: info: MyVolumio login type: Token May 09 17:49:23 vol-office volumio[967]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN May 09 17:49:23 vol-office volumio[967]: info: MyVolumio token set successfully May 09 17:49:23 vol-office volumio[967]: info: MYVOLUMIO: Adding device May 09 17:49:23 vol-office volumio[967]: info: MYVOLUMIO: Evaluating Server May 09 17:49:24 vol-office volumio[967]: info: MyVolumio Plan changed: premium May 09 17:49:24 vol-office volumio[967]: info: [MyVolumio PluginManager] Subscribed plan changed to premium May 09 17:49:24 vol-office volumio[967]: info: Removing browser output: myVolumio user plan is not superstar May 09 17:49:24 vol-office volumio[967]: info: Removing audio output: May 09 17:49:24 vol-office volumio[967]: info: MYVOLUMIO: Adding device May 09 17:49:24 vol-office volumio[967]: info: MYVOLUMIO: Evaluating Server May 09 17:49:24 vol-office volumio[967]: info: Remote config written successfully May 09 17:49:24 vol-office volumio[967]: info: Starting Tunnel 1 May 09 17:49:24 vol-office volumio[967]: info: Starting Tunnel Connection Checker May 09 17:49:24 vol-office volumio[967]: info: MYVolumio Device disabled May 09 17:49:24 vol-office volumio[967]: info: MyVolumio status changed May 09 17:49:24 vol-office volumio[967]: info: Streaming services startup May 09 17:49:24 vol-office volumio[967]: info: Starting Streaming Daemon May 09 17:49:24 vol-office volumio[967]: info: Setting Geolocation for MyVolumio to eu6 May 09 17:49:24 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:24 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:24 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:24 vol-office sudo[2222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 09 17:49:24 vol-office sudo[2222]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:24 vol-office sudo[2222]: pam_unix(sudo:session): session closed for user root May 09 17:49:24 vol-office volumio[967]: error: Cannot start Volumio Streaming Daemon May 09 17:49:24 vol-office volumio[967]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 09 17:49:24 vol-office volumio[967]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 09 17:49:24 vol-office volumio[967]: info: Setting Geolocation for MyVolumio to eu7 May 09 17:49:24 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:25 vol-office volumio[967]: info: MYVolumio Device enabled May 09 17:49:25 vol-office volumio[967]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... May 09 17:49:25 vol-office volumio[967]: info: MyVolumio status changed May 09 17:49:25 vol-office volumio[967]: info: Streaming services startup May 09 17:49:25 vol-office volumio[967]: info: Starting Streaming Daemon May 09 17:49:25 vol-office volumio[967]: error: [MyVolumio PluginManager] Could not read cache file: ENOENT: no such file or directory, open '/data/myvolumio/cache.data' May 09 17:49:25 vol-office sudo[2225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service May 09 17:49:25 vol-office sudo[2225]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:25 vol-office volumio[967]: info: Successfully Added MyVolumio device May 09 17:49:25 vol-office sudo[2225]: pam_unix(sudo:session): session closed for user root May 09 17:49:25 vol-office volumio[967]: error: Cannot start Volumio Streaming Daemon May 09 17:49:25 vol-office volumio[967]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service May 09 17:49:25 vol-office volumio[967]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. May 09 17:49:25 vol-office volumio[967]: info: Updating MyVolumio device info May 09 17:49:25 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:25 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:25 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:25 vol-office volumio[967]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... May 09 17:49:26 vol-office volumio[967]: info: [1746805766041] Starting BluetoothController May 09 17:49:26 vol-office volumio[967]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... May 09 17:49:26 vol-office ntpd[773]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 09 17:49:28 vol-office sudo[2228]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom May 09 17:49:28 vol-office sudo[2228]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:28 vol-office sudo[2228]: pam_unix(sudo:session): session closed for user root May 09 17:49:28 vol-office volumio[967]: info: MRS: MultiRoom plugin initialized May 09 17:49:28 vol-office volumio[967]: info: MRS: STOPPING SNAPCLIENT May 09 17:49:28 vol-office volumio[967]: info: MRS: Snap server stop May 09 17:49:28 vol-office sudo[2244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient May 09 17:49:28 vol-office volumio[967]: info: MRS: STOPPING volumioStreaming May 09 17:49:28 vol-office sudo[2244]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:28 vol-office sudo[2246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver May 09 17:49:28 vol-office sudo[2246]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:28 vol-office sudo[2249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming May 09 17:49:28 vol-office volumio[967]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... May 09 17:49:28 vol-office sudo[2249]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:28 vol-office sudo[2252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* May 09 17:49:28 vol-office sudo[2252]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:28 vol-office sudo[2244]: pam_unix(sudo:session): session closed for user root May 09 17:49:28 vol-office sudo[2252]: pam_unix(sudo:session): session closed for user root May 09 17:49:28 vol-office sudo[2246]: pam_unix(sudo:session): session closed for user root May 09 17:49:28 vol-office volumio[967]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... May 09 17:49:28 vol-office sudo[2249]: pam_unix(sudo:session): session closed for user root May 09 17:49:28 vol-office volumio[967]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... May 09 17:49:28 vol-office volumio[967]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... May 09 17:49:28 vol-office volumio[967]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... May 09 17:49:28 vol-office volumio[967]: info: [MyVolumio PluginManager] Loading plugin "tidal"... May 09 17:49:28 vol-office volumio[967]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... May 09 17:49:28 vol-office volumio[967]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... May 09 17:49:28 vol-office volumio[967]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... May 09 17:49:28 vol-office volumio[967]: info: Preparing to generate the ALSA configuration file May 09 17:49:28 vol-office volumio[967]: info: Updating MyVolumio device info May 09 17:49:28 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:28 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:28 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:28 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid May 09 17:49:28 vol-office volumio[967]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 09 17:49:28 vol-office volumio[967]: info: Reading ALSA contributions from plugins. May 09 17:49:28 vol-office volumio[967]: info: Successfully Added MyVolumio device May 09 17:49:28 vol-office volumio[967]: info: Successfully Updated MyVolumio device May 09 17:49:28 vol-office volumio[967]: info: MRS: Removed streaming files May 09 17:49:28 vol-office volumio[967]: info: MRS: volumioStreaming STOPPED May 09 17:49:28 vol-office volumio[967]: info: MRS: SNAPSERVER STOPPED May 09 17:49:28 vol-office volumio[967]: info: MRS: SNAPCLIENT STOPPED May 09 17:49:28 vol-office volumio[967]: info: Asound.conf file unchanged, so no further update is needed May 09 17:49:28 vol-office volumio[967]: info: Output device has changed, restarting MPD May 09 17:49:28 vol-office volumio[967]: info: Output device has changed, restarting Shairport Sync May 09 17:49:28 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:28 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:28 vol-office sudo[2270]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 09 17:49:28 vol-office sudo[2270]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:28 vol-office sudo[2270]: pam_unix(sudo:session): session closed for user root May 09 17:49:28 vol-office sudo[2272]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 09 17:49:28 vol-office sudo[2272]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:28 vol-office systemd[1]: Stopping Music Player Daemon... May 09 17:49:28 vol-office volumio[967]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 09 17:49:28 vol-office volumio[967]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 09 17:49:28 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:28 vol-office systemd[1]: mpd.service: Succeeded. May 09 17:49:28 vol-office systemd[1]: Stopped Music Player Daemon. May 09 17:49:28 vol-office volumio[967]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth May 09 17:49:28 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 09 17:49:28 vol-office volumio[967]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom May 09 17:49:28 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus May 09 17:49:28 vol-office volumio[967]: info: MRS: Pushing multiroomSync output for this device May 09 17:49:28 vol-office volumio[967]: info: MRS: Pushing multiroomSync output May 09 17:49:28 vol-office systemd[1]: Starting Music Player Daemon... May 09 17:49:28 vol-office sudo[2282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name vol-office May 09 17:49:28 vol-office sudo[2282]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:28 vol-office volumio[967]: info: Adding audio output: May 09 17:49:28 vol-office volumio[967]: info: Adding audio output: May 09 17:49:28 vol-office sudo[2282]: pam_unix(sudo:session): session closed for user root May 09 17:49:28 vol-office volumio[967]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 09 17:49:28 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:28 vol-office volumio[967]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio May 09 17:49:28 vol-office volumio[967]: info: Adding METAVOLUMIO REST API Endpoints May 09 17:49:28 vol-office volumio[967]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio May 09 17:49:28 vol-office volumio[967]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio May 09 17:49:28 vol-office volumio[967]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio May 09 17:49:28 vol-office volumio[967]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio May 09 17:49:28 vol-office volumio[967]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui May 09 17:49:28 vol-office volumio[967]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller May 09 17:49:28 vol-office volumio[967]: info: Preparing CD Folders May 09 17:49:28 vol-office volumio[967]: info: Adding CD REST API Endpoints May 09 17:49:28 vol-office volumio[967]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller May 09 17:49:28 vol-office volumio[967]: info: Starting UDEV Watcher for CD May 09 17:49:28 vol-office volumio[967]: info: Detecting CD presence with UDEV May 09 17:49:28 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices May 09 17:49:28 vol-office volumio[967]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs May 09 17:49:28 vol-office volumio[967]: info: Adding inputs REST Endpoints May 09 17:49:28 vol-office volumio[967]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs May 09 17:49:28 vol-office volumio[967]: info: Scanning Audio Inputs May 09 17:49:28 vol-office sudo[2279]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 09 17:49:28 vol-office sudo[2279]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:28 vol-office sudo[2279]: pam_unix(sudo:session): session closed for user root May 09 17:49:29 vol-office volumio[967]: info: Checking against Known Cards name May 09 17:49:29 vol-office volumio[967]: info: Adding Server instance for streaming May 09 17:49:29 vol-office volumio[967]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio May 09 17:49:29 vol-office volumio[967]: error: Hi Res Audio Failed Login: Missing Login Data May 09 17:49:29 vol-office volumio[967]: info: Adding HIGHRESAUDIO REST API Endpoints May 09 17:49:29 vol-office volumio[967]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio May 09 17:49:29 vol-office volumio[967]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal May 09 17:49:29 vol-office volumio[967]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz May 09 17:49:29 vol-office volumio[967]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect May 09 17:49:29 vol-office volumio[967]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect May 09 17:49:29 vol-office volumio[967]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect May 09 17:49:29 vol-office sudo[2292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 09 17:49:29 vol-office sudo[2292]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:29 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:29 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:29 vol-office volumio[967]: info: QobuzConnect: Setting Qobuz Connect card as outputdevice to 2 May 09 17:49:29 vol-office volumio[967]: info: QobuzConnect: Starting Qobuz Connect socket and service May 09 17:49:29 vol-office sudo[2292]: pam_unix(sudo:session): session closed for user root May 09 17:49:29 vol-office volumio[967]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections May 09 17:49:29 vol-office volumio[967]: info: Stopping AccessToken refresher cron May 09 17:49:29 vol-office sudo[2299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect May 09 17:49:29 vol-office sudo[2299]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:29 vol-office volumio[967]: info: AccessToken refresher cron started May 09 17:49:29 vol-office volumio[967]: info: Stopping AccessToken refresher cron for QOBUZ May 09 17:49:29 vol-office volumio[967]: info: AccessToken refresher cron started for QOBUZ May 09 17:49:29 vol-office volumio[967]: info: Adding TIDAL REST API Endpoints May 09 17:49:29 vol-office volumio[967]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal May 09 17:49:29 vol-office volumio[967]: info: Adding QOBUZ REST API Endpoints May 09 17:49:29 vol-office volumio[967]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz May 09 17:49:29 vol-office volumio[967]: info: Bluetooth name changed to vol-office May 09 17:49:29 vol-office volumio[967]: info: MPD Permissions set May 09 17:49:29 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:29 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:29 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:29 vol-office systemd[1]: Started Volumio Qobuz Connect Service. May 09 17:49:29 vol-office sudo[2299]: pam_unix(sudo:session): session closed for user root May 09 17:49:29 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:29 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:29 vol-office volumio[967]: info: Starting Shairport Sync May 09 17:49:29 vol-office sudo[2312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 09 17:49:29 vol-office sudo[2312]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:29 vol-office systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 09 17:49:29 vol-office systemd[1]: shairport-sync.service: Succeeded. May 09 17:49:29 vol-office systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 09 17:49:29 vol-office volumio[967]: info: Executing endpoint qc_getconfig May 09 17:49:29 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 09 17:49:29 vol-office qobuz-connect[2301]: 20250509 17:49:29.496 [2301.2301] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 09 17:49:29 vol-office volumio[967]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 09 17:49:29 vol-office volumio[967]: info: QobuzConnect: QOBUZ Connect daemon connected May 09 17:49:29 vol-office volumio[967]: info: Preparing to generate the ALSA configuration file May 09 17:49:29 vol-office sudo[2316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service May 09 17:49:29 vol-office systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 09 17:49:29 vol-office sudo[2316]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:29 vol-office sudo[2312]: pam_unix(sudo:session): session closed for user root May 09 17:49:29 vol-office volumio[967]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 09 17:49:29 vol-office volumio[967]: info: Reading ALSA contributions from plugins. May 09 17:49:29 vol-office volumio[967]: info: Shairport-Sync Started May 09 17:49:29 vol-office volumio[967]: info: Asound.conf file unchanged, so no further update is needed May 09 17:49:29 vol-office volumio[967]: info: Output device has changed, restarting MPD May 09 17:49:29 vol-office systemd[1]: Started MyVolumio SSH Tunnel. May 09 17:49:29 vol-office volumio[967]: info: Output device has changed, restarting Shairport Sync May 09 17:49:29 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:29 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:29 vol-office sudo[2316]: pam_unix(sudo:session): session closed for user root May 09 17:49:29 vol-office qobuz-connect[2301]: 20250509 17:49:29.670 [2301.2301] INFO VolumeManager: [0xf9b910]: Setting new playback volume: 75 May 09 17:49:29 vol-office qobuz-connect[2301]: 20250509 17:49:29.671 [2301.2301] INFO VolumeManager: [0xf9b910]: Setting new mute state: 0 May 09 17:49:29 vol-office qobuz-connect[2301]: 20250509 17:49:29.671 [2301.2301] INFO QobuzConnect: [0xf9c2e0]: Client initialized! May 09 17:49:29 vol-office qobuz-connect[2301]: 20250509 17:49:29.672 [2301.2301] INFO SampleApp: Starting Avahi advertising, name: vol-office, service name: _qobuz-connect._tcp May 09 17:49:29 vol-office sudo[2321]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 09 17:49:29 vol-office sudo[2325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 09 17:49:29 vol-office sudo[2325]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:29 vol-office sudo[2321]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:29 vol-office qobuz-connect[2301]: 20250509 17:49:29.706 [2301.2301] INFO LocalConfigManager: [0xf9b1f0]: Starting Local Configuration server May 09 17:49:29 vol-office qobuz-connect[2301]: 20250509 17:49:29.706 [2301.2301] INFO SampleApp: Starting Local configuration server May 09 17:49:29 vol-office qobuz-connect[2301]: 20250509 17:49:29.706 [2301.2301] INFO SampleApp: Playback volume changed: 75 May 09 17:49:29 vol-office qobuz-connect[2301]: 20250509 17:49:29.707 [2301.2301] INFO SampleApp: Connected to UNIX socket client 0xf90f60 May 09 17:49:29 vol-office autossh[2326]: port set to 0, monitoring disabled May 09 17:49:29 vol-office autossh[2326]: starting ssh (count 1) May 09 17:49:29 vol-office autossh[2326]: ssh child pid is 2335 May 09 17:49:29 vol-office sudo[2321]: pam_unix(sudo:session): session closed for user root May 09 17:49:29 vol-office volumio[967]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 09 17:49:29 vol-office systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 09 17:49:29 vol-office volumio[967]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 09 17:49:29 vol-office systemd[1]: mpd.service: Succeeded. May 09 17:49:29 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:29 vol-office systemd[1]: Stopped Music Player Daemon. May 09 17:49:29 vol-office volumio[967]: info: QobuzConnect: setDeactiveState invoked May 09 17:49:29 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:29 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:29 vol-office volumio[967]: info: Preparing to generate the ALSA configuration file May 09 17:49:29 vol-office systemd[1]: Starting Music Player Daemon... May 09 17:49:29 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:29 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:29 vol-office volumio[967]: info: QobuzConnect: Setting Qobuz Connect card as outputdevice to 2 May 09 17:49:29 vol-office volumio[967]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 09 17:49:29 vol-office volumio[967]: info: Reading ALSA contributions from plugins. May 09 17:49:29 vol-office volumio[967]: info: Successfully Updated MyVolumio device May 09 17:49:29 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:29 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:29 vol-office sudo[2343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect May 09 17:49:29 vol-office sudo[2343]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:29 vol-office volumio[967]: info: MPD Permissions set May 09 17:49:29 vol-office volumio[967]: info: Remote SSH Started May 09 17:49:29 vol-office systemd[1]: Stopping Volumio Qobuz Connect Service... May 09 17:49:29 vol-office qobuz-connect[2301]: 20250509 17:49:29.898 [2301.2301] INFO SampleApp: Stopping Local configuration server May 09 17:49:29 vol-office qobuz-connect[2301]: 20250509 17:49:29.909 [2301.2301] INFO SampleApp: shat down connection on UNIX socket May 09 17:49:29 vol-office volumiossh-tunnel[2324]: Warning: Permanently added '[eu7.myvolumio.org]:2222,[167.71.43.69]:2222' (RSA) to the list of known hosts. May 09 17:49:29 vol-office sudo[2336]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 09 17:49:29 vol-office systemd[1]: qobuz-connect.service: Succeeded. May 09 17:49:29 vol-office sudo[2336]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:29 vol-office systemd[1]: Stopped Volumio Qobuz Connect Service. May 09 17:49:29 vol-office sudo[2336]: pam_unix(sudo:session): session closed for user root May 09 17:49:29 vol-office systemd[1]: Started Volumio Qobuz Connect Service. May 09 17:49:29 vol-office sudo[2343]: pam_unix(sudo:session): session closed for user root May 09 17:49:30 vol-office volumio[967]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected May 09 17:49:30 vol-office volumio[967]: info: QobuzConnect: setDeactiveState invoked May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:30 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:30 vol-office volumio[967]: info: Executing endpoint qc_getconfig May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 09 17:49:30 vol-office qobuz-connect[2347]: 20250509 17:49:30.171 [2347.2347] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:30 vol-office qobuz-connect[2347]: 20250509 17:49:30.179 [2347.2347] INFO VolumeManager: [0x1ffe910]: Setting new playback volume: 75 May 09 17:49:30 vol-office qobuz-connect[2347]: 20250509 17:49:30.179 [2347.2347] INFO VolumeManager: [0x1ffe910]: Setting new mute state: 0 May 09 17:49:30 vol-office qobuz-connect[2347]: 20250509 17:49:30.179 [2347.2347] INFO QobuzConnect: [0x1fff2e0]: Client initialized! May 09 17:49:30 vol-office qobuz-connect[2347]: 20250509 17:49:30.179 [2347.2347] INFO SampleApp: Starting Avahi advertising, name: vol-office, service name: _qobuz-connect._tcp May 09 17:49:30 vol-office qobuz-connect[2347]: 20250509 17:49:30.206 [2347.2347] INFO LocalConfigManager: [0x1ffe1f0]: Starting Local Configuration server May 09 17:49:30 vol-office qobuz-connect[2347]: 20250509 17:49:30.206 [2347.2347] INFO SampleApp: Starting Local configuration server May 09 17:49:30 vol-office qobuz-connect[2347]: 20250509 17:49:30.207 [2347.2347] INFO SampleApp: Connected to UNIX socket client 0x1ff3f60 May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:30 vol-office volumio[967]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 May 09 17:49:30 vol-office volumio[967]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 09 17:49:30 vol-office volumio[967]: info: QobuzConnect: QOBUZ Connect daemon connected May 09 17:49:30 vol-office volumio[967]: info: Starting Shairport Sync May 09 17:49:30 vol-office sudo[2356]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 09 17:49:30 vol-office sudo[2356]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:30 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:30 vol-office qobuz-connect[2347]: 20250509 17:49:30.320 [2347.2347] INFO SampleApp: Playback volume changed: 75 May 09 17:49:30 vol-office systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 09 17:49:30 vol-office systemd[1]: shairport-sync.service: Succeeded. May 09 17:49:30 vol-office systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 09 17:49:30 vol-office volumio[967]: info: Asound.conf file unchanged, so no further update is needed May 09 17:49:30 vol-office volumio[967]: info: Output device has changed, restarting MPD May 09 17:49:30 vol-office systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 09 17:49:30 vol-office volumio[967]: info: Output device has changed, restarting Shairport Sync May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:30 vol-office sudo[2356]: pam_unix(sudo:session): session closed for user root May 09 17:49:30 vol-office sudo[2360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 09 17:49:30 vol-office sudo[2360]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:30 vol-office sudo[2360]: pam_unix(sudo:session): session closed for user root May 09 17:49:30 vol-office sudo[2363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 09 17:49:30 vol-office sudo[2363]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:30 vol-office volumio[967]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 09 17:49:30 vol-office volumio[967]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:30 vol-office systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 09 17:49:30 vol-office systemd[1]: mpd.service: Succeeded. May 09 17:49:30 vol-office systemd[1]: Stopped Music Player Daemon. May 09 17:49:30 vol-office volumio[967]: info: QobuzConnect: setDeactiveState invoked May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:30 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:30 vol-office systemd[1]: Starting Music Player Daemon... May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:30 vol-office volumio[967]: info: QobuzConnect: Setting Qobuz Connect card as outputdevice to 2 May 09 17:49:30 vol-office sudo[2378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect May 09 17:49:30 vol-office sudo[2378]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:30 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:30 vol-office qobuz-connect[2347]: 20250509 17:49:30.612 [2347.2347] INFO SampleApp: Stopping Local configuration server May 09 17:49:30 vol-office systemd[1]: Stopping Volumio Qobuz Connect Service... May 09 17:49:30 vol-office volumio[967]: info: MPD Permissions set May 09 17:49:30 vol-office volumio[967]: info: Shairport-Sync Started May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:30 vol-office qobuz-connect[2347]: 20250509 17:49:30.623 [2347.2347] INFO SampleApp: shat down connection on UNIX socket May 09 17:49:30 vol-office systemd[1]: qobuz-connect.service: Succeeded. May 09 17:49:30 vol-office systemd[1]: Stopped Volumio Qobuz Connect Service. May 09 17:49:30 vol-office sudo[2373]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:49:30 vol-office volumio[967]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected May 09 17:49:30 vol-office volumio[967]: info: QobuzConnect: setDeactiveState invoked May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:30 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:30 vol-office volumio[967]: info: Starting Shairport Sync May 09 17:49:30 vol-office sudo[2373]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:30 vol-office sudo[2373]: pam_unix(sudo:session): session closed for user root May 09 17:49:30 vol-office sudo[2387]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 09 17:49:30 vol-office sudo[2387]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:30 vol-office systemd[1]: Started Volumio Qobuz Connect Service. May 09 17:49:30 vol-office sudo[2378]: pam_unix(sudo:session): session closed for user root May 09 17:49:30 vol-office volumio[967]: info: Executing endpoint qc_getconfig May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 09 17:49:30 vol-office qobuz-connect[2381]: 20250509 17:49:30.777 [2381.2381] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 09 17:49:30 vol-office systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 09 17:49:30 vol-office qobuz-connect[2381]: 20250509 17:49:30.785 [2381.2381] INFO VolumeManager: [0x2471910]: Setting new playback volume: 75 May 09 17:49:30 vol-office qobuz-connect[2381]: 20250509 17:49:30.785 [2381.2381] INFO VolumeManager: [0x2471910]: Setting new mute state: 0 May 09 17:49:30 vol-office qobuz-connect[2381]: 20250509 17:49:30.785 [2381.2381] INFO QobuzConnect: [0x24722e0]: Client initialized! May 09 17:49:30 vol-office qobuz-connect[2381]: 20250509 17:49:30.785 [2381.2381] INFO SampleApp: Starting Avahi advertising, name: vol-office, service name: _qobuz-connect._tcp May 09 17:49:30 vol-office systemd[1]: shairport-sync.service: Succeeded. May 09 17:49:30 vol-office systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 09 17:49:30 vol-office volumio[967]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 09 17:49:30 vol-office volumio[967]: info: QobuzConnect: QOBUZ Connect daemon connected May 09 17:49:30 vol-office systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 09 17:49:30 vol-office sudo[2387]: pam_unix(sudo:session): session closed for user root May 09 17:49:30 vol-office volumio[967]: info: Shairport-Sync Started May 09 17:49:30 vol-office qobuz-connect[2381]: 20250509 17:49:30.818 [2381.2381] INFO LocalConfigManager: [0x24711f0]: Starting Local Configuration server May 09 17:49:30 vol-office qobuz-connect[2381]: 20250509 17:49:30.818 [2381.2381] INFO SampleApp: Starting Local configuration server May 09 17:49:30 vol-office qobuz-connect[2381]: 20250509 17:49:30.819 [2381.2381] INFO SampleApp: Connected to UNIX socket client 0x2466f60 May 09 17:49:30 vol-office qobuz-connect[2381]: 20250509 17:49:30.927 [2381.2381] INFO SampleApp: Playback volume changed: 75 May 09 17:49:30 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:30 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:31 vol-office sudo[2397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service May 09 17:49:31 vol-office sudo[2397]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:31 vol-office systemd[1]: Started Volumio Bluetooth Module. May 09 17:49:31 vol-office sudo[2397]: pam_unix(sudo:session): session closed for user root May 09 17:49:32 vol-office sudo[2400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth/* May 09 17:49:32 vol-office volumio[967]: info: Volumio BT Module successfully started May 09 17:49:32 vol-office sudo[2400]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:32 vol-office volumiobt[2399]: /bin/chmod: cannot access '/var/lib/bluetooth/*': No such file or directory May 09 17:49:32 vol-office sudo[2400]: pam_unix(sudo:session): session closed for user root May 09 17:49:32 vol-office mpd[2390]: May 09 17:49 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 09 17:49:32 vol-office systemd[1]: Started Music Player Daemon. May 09 17:49:32 vol-office volumio[967]: info: TidalConnect service stoped! May 09 17:49:32 vol-office sudo[2325]: pam_unix(sudo:session): session closed for user root May 09 17:49:32 vol-office sudo[2363]: pam_unix(sudo:session): session closed for user root May 09 17:49:32 vol-office sudo[2272]: pam_unix(sudo:session): session closed for user root May 09 17:49:32 vol-office volumio[967]: error: MPD error: The expression evaluated to a falsy value: May 09 17:49:32 vol-office volumio[967]: assert.ok(self.idling) May 09 17:49:32 vol-office volumio[967]: error: The expression evaluated to a falsy value: May 09 17:49:32 vol-office volumio[967]: assert.ok(self.idling) May 09 17:49:32 vol-office volumio[967]: error: MPD error: The expression evaluated to a falsy value: May 09 17:49:32 vol-office volumio[967]: assert.ok(self.idling) May 09 17:49:32 vol-office volumio[967]: error: The expression evaluated to a falsy value: May 09 17:49:32 vol-office volumio[967]: assert.ok(self.idling) May 09 17:49:32 vol-office volumio[967]: error: updateQueue error: null May 09 17:49:32 vol-office volumio[967]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 09 17:49:32 vol-office volumio[967]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect May 09 17:49:32 vol-office sudo[2414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 09 17:49:32 vol-office sudo[2414]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:32 vol-office systemd[1]: Started Volumio Tidal Connect Service. May 09 17:49:32 vol-office sudo[2414]: pam_unix(sudo:session): session closed for user root May 09 17:49:32 vol-office volumio[967]: info: Executing endpoint tc_getconfig May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig May 09 17:49:32 vol-office vtcs[2416]: STARTING TidalConnect services, version: 1.4.0.34 May 09 17:49:32 vol-office vtcs[2416]: STARTED TidalConnect services. May 09 17:49:32 vol-office volumio[967]: info: Executing endpoint tc_connect May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect May 09 17:49:32 vol-office volumio[967]: info: Connecting to TidalConnect May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::servicePushState May 09 17:49:32 vol-office volumio[967]: info: CoreStateMachine::pushState May 09 17:49:32 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::volumioPushState May 09 17:49:32 vol-office volumio[967]: info: MRS: Pushing multiroomSync output update for this device May 09 17:49:32 vol-office volumio[967]: info: MRS: Pushing multiroomSync output May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:32 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:32 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:32 vol-office volumio[967]: 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} May 09 17:49:32 vol-office volumio[967]: verbose: CURRENT POSITION 0 May 09 17:49:32 vol-office volumio[967]: info: CoreStateMachine::syncState stateService stop May 09 17:49:32 vol-office volumio[967]: info: CoreStateMachine::syncState currentStatus stop May 09 17:49:32 vol-office volumio[967]: info: CoreStateMachine::pushState May 09 17:49:32 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::volumioPushState May 09 17:49:32 vol-office volumio[967]: info: MRS: Pushing multiroomSync output update for this device May 09 17:49:32 vol-office volumio[967]: info: MRS: Pushing multiroomSync output May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:32 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:32 vol-office volumio[967]: info: No code May 09 17:49:32 vol-office volumio[967]: info: CoreStateMachine::pushState May 09 17:49:32 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::volumioPushState May 09 17:49:32 vol-office volumio[967]: info: MRS: Pushing multiroomSync output update for this device May 09 17:49:32 vol-office volumio[967]: info: MRS: Pushing multiroomSync output May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:32 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::servicePushState May 09 17:49:32 vol-office volumio[967]: info: CoreStateMachine::pushState May 09 17:49:32 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::volumioPushState May 09 17:49:32 vol-office volumio[967]: info: MRS: Pushing multiroomSync output update for this device May 09 17:49:32 vol-office volumio[967]: info: MRS: Pushing multiroomSync output May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:32 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:32 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:32 vol-office volumio[967]: 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} May 09 17:49:32 vol-office volumio[967]: verbose: CURRENT POSITION 0 May 09 17:49:32 vol-office volumio[967]: info: CoreStateMachine::syncState stateService stop May 09 17:49:32 vol-office volumio[967]: info: CoreStateMachine::syncState currentStatus stop May 09 17:49:32 vol-office volumio[967]: info: CoreStateMachine::pushState May 09 17:49:32 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::volumioPushState May 09 17:49:32 vol-office volumio[967]: info: MRS: Pushing multiroomSync output update for this device May 09 17:49:32 vol-office volumio[967]: info: MRS: Pushing multiroomSync output May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:32 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:32 vol-office volumio[967]: info: No code May 09 17:49:32 vol-office volumio[967]: info: CoreStateMachine::pushState May 09 17:49:32 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::volumioPushState May 09 17:49:32 vol-office volumio[967]: info: MRS: Pushing multiroomSync output update for this device May 09 17:49:32 vol-office volumio[967]: info: MRS: Pushing multiroomSync output May 09 17:49:32 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:32 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:33 vol-office sudo[2435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall pulseaudio May 09 17:49:33 vol-office sudo[2435]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:33 vol-office volumiobt[2399]: pulseaudio: no process found May 09 17:49:33 vol-office sudo[2435]: pam_unix(sudo:session): session closed for user root May 09 17:49:33 vol-office dbus-daemon[646]: [system] Activating via systemd: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' requested by ':1.28' (uid=1000 pid=2439 comm="/usr/bin/pulseaudio --high-priority=true ") May 09 17:49:33 vol-office systemd[1]: Starting RealtimeKit Scheduling Policy Service... May 09 17:49:33 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: running May 09 17:49:33 vol-office dbus-daemon[646]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' May 09 17:49:33 vol-office systemd[1]: Started RealtimeKit Scheduling Policy Service. May 09 17:49:33 vol-office rtkit-daemon[2440]: Successfully called chroot. May 09 17:49:33 vol-office rtkit-daemon[2440]: Successfully dropped privileges. May 09 17:49:33 vol-office rtkit-daemon[2440]: Successfully limited resources. May 09 17:49:33 vol-office rtkit-daemon[2440]: Running. May 09 17:49:33 vol-office rtkit-daemon[2440]: Canary thread running. May 09 17:49:33 vol-office rtkit-daemon[2440]: Watchdog thread running. May 09 17:49:33 vol-office dbus-daemon[646]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkit.service' requested by ':1.29' (uid=0 pid=2440 comm="/usr/lib/rtkit/rtkit-daemon ") May 09 17:49:33 vol-office systemd[1]: Starting Authorization Manager... May 09 17:49:33 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: running May 09 17:49:33 vol-office polkitd[2444]: started daemon version 0.105 using authority implementation `local' version `0.105' May 09 17:49:33 vol-office dbus-daemon[646]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' May 09 17:49:33 vol-office systemd[1]: Started Authorization Manager. May 09 17:49:33 vol-office pulseaudio[2439]: Failed to open cookie file '/home/volumio/.config/pulse/cookie': No such file or directory May 09 17:49:33 vol-office pulseaudio[2439]: Failed to load authentication key '/home/volumio/.config/pulse/cookie': No such file or directory May 09 17:49:33 vol-office pulseaudio[2439]: Failed to open cookie file '/home/volumio/.pulse-cookie': No such file or directory May 09 17:49:33 vol-office pulseaudio[2439]: Failed to load authentication key '/home/volumio/.pulse-cookie': No such file or directory May 09 17:49:33 vol-office pulseaudio[2439]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 May 09 17:49:33 vol-office pulseaudio[2439]: Unable to contact D-Bus: org.freedesktop.DBus.Error.NotSupported: Unable to autolaunch a dbus-daemon without a $DISPLAY for X11 May 09 17:49:33 vol-office volumiobt[2399]: Applying permissions May 09 17:49:33 vol-office volumiobt[2399]: Setting BT discoverable and pairable May 09 17:49:33 vol-office bluetoothd[767]: Endpoint registered: sender=:1.49 path=/MediaEndpoint/A2DPSource May 09 17:49:33 vol-office pulseaudio[2439]: 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 May 09 17:49:33 vol-office bluetoothd[767]: Endpoint registered: sender=:1.49 path=/MediaEndpoint/A2DPSink May 09 17:49:33 vol-office kernel: Bluetooth: RFCOMM TTY layer initialized May 09 17:49:33 vol-office kernel: Bluetooth: RFCOMM socket layer initialized May 09 17:49:33 vol-office kernel: Bluetooth: RFCOMM ver 1.11 May 09 17:49:33 vol-office volumiobt[2399]: Agent registered May 09 17:49:33 vol-office volumiobt[2399]: [117B blob data] May 09 17:49:33 vol-office volumiobt[2399]: [117B blob data] May 09 17:49:33 vol-office volumiobt[2399]: [117B blob data] May 09 17:49:33 vol-office volumiobt[2399]: [117B blob data] May 09 17:49:33 vol-office volumiobt[2399]: [117B blob data] May 09 17:49:33 vol-office volumiobt[2399]: [117B blob data] May 09 17:49:33 vol-office volumiobt[2399]: [117B blob data] May 09 17:49:33 vol-office volumiobt[2399]: [117B blob data] May 09 17:49:33 vol-office volumiobt[2399]: [117B blob data] May 09 17:49:33 vol-office volumiobt[2399]: [bluetooth]# -e power on May 09 17:49:33 vol-office volumiobt[2399]: Invalid command in menu main: -e May 09 17:49:33 vol-office volumiobt[2399]: May 09 17:49:33 vol-office volumiobt[2399]: Use "help" for a list of available commands in a menu. May 09 17:49:33 vol-office volumiobt[2399]: Use "menu " if you want to enter any submenu. May 09 17:49:33 vol-office volumiobt[2399]: Use "back" if you want to return to menu main. May 09 17:49:33 vol-office volumiobt[2399]: [bluetooth]# agent on May 09 17:49:33 vol-office volumiobt[2399]: Agent is already registered May 09 17:49:33 vol-office volumiobt[2399]: [bluetooth]# discoverable on May 09 17:49:33 vol-office volumiobt[2399]: [bluetooth]# pairable on May 09 17:49:33 vol-office volumiobt[2399]: [bluetooth]# agent NoInputNoOutput May 09 17:49:33 vol-office volumiobt[2399]: Agent is already registered May 09 17:49:33 vol-office volumiobt[2399]: [bluetooth]# default-agent May 09 17:49:33 vol-office volumiobt[2399]: [bluetooth]# quit May 09 17:49:33 vol-office volumiobt[2399]: [59B blob data] May 09 17:49:33 vol-office volumio[967]: info: MRS: Getting audio outputs on start May 09 17:49:33 vol-office volumio[967]: info: MRS: Requesting all other devices output May 09 17:49:35 vol-office volumio[967]: info: TidalConnect service started! May 09 17:49:41 vol-office sudo[2473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 09 17:49:41 vol-office sudo[2473]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:41 vol-office sudo[2473]: pam_unix(sudo:session): session closed for user root May 09 17:49:41 vol-office sudo[2475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 17:49:41 vol-office sudo[2475]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:41 vol-office sudo[2475]: pam_unix(sudo:session): session closed for user root May 09 17:49:41 vol-office volumio[967]: verbose: New Socket.io Connection to 192.168.178.48 from 192.168.178.20 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:138.0) Gecko/20100101 Firefox/138.0 Engine version: 3 Transport: polling Total Clients: 6 May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:41 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:41 vol-office volumio[967]: info: Received Get System Info May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 17:49:41 vol-office volumio[967]: info: Discovery: Getting this device information May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:41 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:41 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::volumioGetVisibleSources May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:41 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:41 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 09 17:49:41 vol-office volumio[967]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 09 17:49:41 vol-office volumio[967]: info: Received Get System Info May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 17:49:41 vol-office volumio[967]: info: Discovery: Getting this device information May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:41 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:41 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:41 vol-office volumio[967]: info: Listing playlists May 09 17:49:41 vol-office volumio[967]: info: Received Get System Info May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 09 17:49:41 vol-office volumio[967]: info: Discovery: Getting this device information May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:41 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:41 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:41 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 09 17:49:42 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:49:42 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:49:44 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 09 17:49:44 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 09 17:49:51 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 09 17:49:54 vol-office volumio[967]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf May 09 17:49:58 vol-office volumio[967]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf May 09 17:49:58 vol-office volumio[967]: info: Folder /tmp/plugins removed May 09 17:49:58 vol-office volumio[967]: info: Check plugin dependencies May 09 17:49:58 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 09 17:49:58 vol-office volumio[967]: info: Checking if plugin already exists May 09 17:49:58 vol-office volumio[967]: info: Rename folder May 09 17:49:58 vol-office volumio[967]: info: Folder /tmp/downloaded_plugin.zip removed May 09 17:49:58 vol-office volumio[967]: info: Move to category May 09 17:49:59 vol-office volumio[967]: info: Checking if install.sh is present May 09 17:49:59 vol-office volumio[967]: info: Executing install.sh May 09 17:49:59 vol-office sudo[2524]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh May 09 17:49:59 vol-office sudo[2524]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:59 vol-office volumio[967]: info: creating filters folder and copying demo filters May 09 17:49:59 vol-office volumio[967]: info: copying demo flters May 09 17:49:59 vol-office volumio[967]: info: ./presets/ May 09 17:49:59 vol-office volumio[967]: info: ./presets/2XEQ15/ May 09 17:49:59 vol-office volumio[967]: info: ./presets/2XEQ15/.Bass-FusionDsp.json May 09 17:49:59 vol-office volumio[967]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json May 09 17:49:59 vol-office volumio[967]: info: ./presets/2XEQ15/.Classic-FusionDsp.json May 09 17:49:59 vol-office sudo[2549]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update May 09 17:49:59 vol-office sudo[2549]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:49:59 vol-office volumio[967]: info: ./presets/2XEQ15/.Voice-FusionDsp.json May 09 17:49:59 vol-office volumio[967]: info: ./presets/2XEQ15/.Rock-FusionDsp.json May 09 17:49:59 vol-office volumio[967]: info: ./presets/PEQ/ May 09 17:50:00 vol-office volumio[967]: info: ./presets/convfir/ May 09 17:50:00 vol-office volumio[967]: info: ./presets/convfir/kef.json May 09 17:50:00 vol-office volumio[967]: info: ./presets/convfir/test.json May 09 17:50:00 vol-office volumio[967]: info: ./presets/EQ15/ May 09 17:50:00 vol-office volumio[967]: info: ./presets/EQ15/.Bass-FusionDsp.json May 09 17:50:00 vol-office volumio[967]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json May 09 17:50:00 vol-office volumio[967]: info: ./presets/EQ15/.Classic-FusionDsp.json May 09 17:50:00 vol-office volumio[967]: info: ./presets/EQ15/.Voice-FusionDsp.json May 09 17:50:00 vol-office volumio[967]: info: ./presets/EQ15/.Rock-FusionDsp.json May 09 17:50:00 vol-office volumio[967]: info: Installing/fusiondsp dependencies May 09 17:50:00 vol-office volumio[967]: info: Get:1 http://raspbian.raspberrypi.org/raspbian buster InRelease [15.0 kB] May 09 17:50:00 vol-office volumio[967]: info: Get:2 http://archive.raspberrypi.org/debian buster InRelease [54.2 kB] May 09 17:50:00 vol-office volumio[967]: info: Get:3 https://deb.nodesource.com/node_14.x buster InRelease [4584 B] May 09 17:50:00 vol-office volumio[967]: info: Get:4 http://raspbian.raspberrypi.org/raspbian buster/main armhf Packages [13.0 MB] May 09 17:50:01 vol-office volumio[967]: info: Get:5 http://archive.raspberrypi.org/debian buster/main armhf Packages [400 kB] May 09 17:50:01 vol-office volumio[967]: info: Get:6 https://deb.nodesource.com/node_14.x buster/main armhf Packages [786 B] May 09 17:50:03 vol-office volumio[967]: info: Get:7 http://raspbian.raspberrypi.org/raspbian buster/contrib armhf Packages [58.8 kB] May 09 17:50:03 vol-office volumio[967]: info: Get:8 http://raspbian.raspberrypi.org/raspbian buster/non-free armhf Packages [110 kB] May 09 17:50:04 vol-office volumio[967]: info: Get:9 http://raspbian.raspberrypi.org/raspbian buster/rpi armhf Packages [1360 B] May 09 17:50:11 vol-office volumio[967]: info: Fetched 13.7 MB in 11s (1251 kB/s) May 09 17:50:15 vol-office kernel: EXT4-fs (mmcblk0p3): Delayed block allocation failed for inode 245 at logical offset 4938 with max blocks 2 with error 117 May 09 17:50:15 vol-office kernel: EXT4-fs (mmcblk0p3): This should not happen!! Data will be lost May 09 17:50:15 vol-office kernel: EXT4-fs (mmcblk0p3): Delayed block allocation failed for inode 245 at logical offset 7338 with max blocks 2 with error 117 May 09 17:50:15 vol-office kernel: EXT4-fs (mmcblk0p3): This should not happen!! Data will be lost May 09 17:50:15 vol-office kernel: EXT4-fs (mmcblk0p3): Delayed block allocation failed for inode 245 at logical offset 9388 with max blocks 2048 with error 117 May 09 17:50:15 vol-office kernel: EXT4-fs (mmcblk0p3): This should not happen!! Data will be lost May 09 17:50:15 vol-office kernel: EXT4-fs (mmcblk0p3): Delayed block allocation failed for inode 245 at logical offset 11440 with max blocks 2048 with error 117 May 09 17:50:15 vol-office kernel: EXT4-fs (mmcblk0p3): This should not happen!! Data will be lost May 09 17:50:15 vol-office kernel: EXT4-fs (mmcblk0p3): Delayed block allocation failed for inode 245 at logical offset 13492 with max blocks 2048 with error 117 May 09 17:50:15 vol-office kernel: EXT4-fs (mmcblk0p3): This should not happen!! Data will be lost May 09 17:50:16 vol-office volumio[967]: info: Reading package lists... May 09 17:50:16 vol-office sudo[2549]: pam_unix(sudo:session): session closed for user root May 09 17:50:17 vol-office sudo[2807]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip May 09 17:50:17 vol-office sudo[2807]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:21 vol-office volumio[967]: info: Reading package lists... May 09 17:50:21 vol-office sudo[2807]: pam_unix(sudo:session): session closed for user root May 09 17:50:21 vol-office sudo[2826]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / May 09 17:50:21 vol-office sudo[2826]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:21 vol-office volumio[967]: info: lib/systemd/system/fusiondsp.service May 09 17:50:21 vol-office sudo[2826]: pam_unix(sudo:session): session closed for user root May 09 17:50:22 vol-office volumio[967]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant May 09 17:50:22 vol-office volumio[967]: info: more info at http://www.winimage.com/zLibDll/unzip.html May 09 17:50:22 vol-office volumio[967]: info: May 09 17:50:22 vol-office volumio[967]: info: Cannot open cgui-1.0.0.zip or cgui-1.0.0.zip.zip May 09 17:50:22 vol-office sudo[2830]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui May 09 17:50:22 vol-office sudo[2830]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:22 vol-office sudo[2830]: pam_unix(sudo:session): session closed for user root May 09 17:50:22 vol-office sudo[2832]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui May 09 17:50:22 vol-office sudo[2832]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:22 vol-office sudo[2832]: pam_unix(sudo:session): session closed for user root May 09 17:50:22 vol-office sudo[2834]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip May 09 17:50:22 vol-office sudo[2834]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:22 vol-office sudo[2834]: pam_unix(sudo:session): session closed for user root May 09 17:50:22 vol-office volumio[967]: info: copying hw detection script May 09 17:50:22 vol-office volumio[967]: info: Detected cpu architecture as armv7l May 09 17:50:24 vol-office sudo[2847]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/cp /data/plugins/audio_interface/fusiondsp/c/hw_params_arm /data/plugins/audio_interface/fusiondsp/hw_params May 09 17:50:24 vol-office sudo[2847]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:24 vol-office sudo[2847]: pam_unix(sudo:session): session closed for user root May 09 17:50:24 vol-office sudo[2849]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params May 09 17:50:24 vol-office sudo[2849]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:24 vol-office sudo[2849]: pam_unix(sudo:session): session closed for user root May 09 17:50:24 vol-office sudo[2851]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc May 09 17:50:24 vol-office sudo[2851]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:29 vol-office volumio[967]: info: Reading package lists... May 09 17:50:29 vol-office sudo[2851]: pam_unix(sudo:session): session closed for user root May 09 17:50:29 vol-office sudo[2524]: pam_unix(sudo:session): session closed for user root May 09 17:50:29 vol-office volumio[967]: info: Install script completed May 09 17:50:29 vol-office volumio[967]: info: Adding reference to registry May 09 17:50:29 vol-office volumio[967]: info: Done installing plugin. May 09 17:50:29 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 09 17:50:29 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 09 17:50:29 vol-office volumio[967]: Plugin install end detected on script May 09 17:50:29 vol-office volumio[967]: info: Folder /tmp/plugins removed May 09 17:50:29 vol-office volumio[967]: info: Folder /tmp/downloaded_plugin.zip removed May 09 17:50:29 vol-office volumio[967]: info: Folder /data/temp removed May 09 17:50:32 vol-office volumio[967]: info: Enabling plugin fusiondsp May 09 17:50:32 vol-office volumio[967]: info: Loading plugin "fusiondsp"... May 09 17:50:33 vol-office volumio[967]: error: Could not copy default configuration to /data/configuration/audio_interface/fusiondsp/config.json May 09 17:50:33 vol-office volumio[967]: info: Preparing to generate the ALSA configuration file May 09 17:50:33 vol-office volumio[967]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 09 17:50:33 vol-office volumio[967]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 09 17:50:33 vol-office volumio[967]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 09 17:50:33 vol-office volumio[967]: info: Reading ALSA contributions from plugins. May 09 17:50:33 vol-office volumio[967]: error: Cannot write /etc/asound.conf: Error: ENOSPC: no space left on device, write May 09 17:50:33 vol-office volumio[967]: info: Output device has changed, restarting MPD May 09 17:50:33 vol-office volumio[967]: info: Output device has changed, restarting Shairport Sync May 09 17:50:33 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:50:33 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:50:33 vol-office sudo[2874]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 09 17:50:33 vol-office sudo[2874]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:33 vol-office sudo[2872]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 09 17:50:33 vol-office sudo[2872]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:33 vol-office sudo[2872]: pam_unix(sudo:session): session closed for user root May 09 17:50:33 vol-office systemd[1]: Stopping Music Player Daemon... May 09 17:50:33 vol-office volumio[967]: xcb_connection_has_error() returned true May 09 17:50:33 vol-office volumio[967]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 09 17:50:33 vol-office volumio[967]: xcb_connection_has_error() returned true May 09 17:50:33 vol-office volumio[967]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 09 17:50:33 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:50:33 vol-office systemd[1]: mpd.service: Succeeded. May 09 17:50:33 vol-office systemd[1]: Stopped Music Player Daemon. May 09 17:50:33 vol-office volumio[967]: info: QobuzConnect: setDeactiveState invoked May 09 17:50:33 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:50:33 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:50:33 vol-office vtcs[2416]: [2025-05-09 17:50:33.538] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected May 09 17:50:33 vol-office vtcs[2416]: [2025-05-09 17:50:33.538] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE May 09 17:50:33 vol-office systemd[1]: Starting Music Player Daemon... May 09 17:50:33 vol-office volumio[967]: info: PLUGIN START: fusiondsp May 09 17:50:33 vol-office sudo[2884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 09 17:50:33 vol-office sudo[2884]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:33 vol-office systemd[1]: Stopping Volumio Tidal Connect Service... May 09 17:50:33 vol-office volumio[967]: info: Loading i18n strings for locale de May 09 17:50:33 vol-office systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM May 09 17:50:33 vol-office systemd[1]: vtcs.service: Succeeded. May 09 17:50:33 vol-office systemd[1]: Stopped Volumio Tidal Connect Service. May 09 17:50:33 vol-office sudo[2884]: pam_unix(sudo:session): session closed for user root May 09 17:50:33 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 09 17:50:33 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:50:33 vol-office volumio[967]: info: FusionDsp - mixtype--------------------- Software May 09 17:50:33 vol-office volumio[967]: info: Preparing to generate the ALSA configuration file May 09 17:50:33 vol-office volumio[967]: info: Done. May 09 17:50:33 vol-office sudo[2882]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 09 17:50:33 vol-office sudo[2882]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:33 vol-office sudo[2882]: pam_unix(sudo:session): session closed for user root May 09 17:50:33 vol-office sudo[2890]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 09 17:50:33 vol-office sudo[2890]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:33 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:50:33 vol-office volumio[967]: info: QobuzConnect: Setting Qobuz Connect card as outputdevice to 2 May 09 17:50:33 vol-office volumio[967]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf May 09 17:50:33 vol-office volumio[967]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf May 09 17:50:33 vol-office volumio[967]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 09 17:50:33 vol-office volumio[967]: info: Reading ALSA contributions from plugins. May 09 17:50:33 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: running May 09 17:50:33 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 09 17:50:33 vol-office sudo[2896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect May 09 17:50:33 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: running May 09 17:50:33 vol-office sudo[2896]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:33 vol-office systemd[1]: Stopping Volumio Qobuz Connect Service... May 09 17:50:33 vol-office qobuz-connect[2381]: 20250509 17:50:33.839 [2381.2381] INFO SampleApp: Stopping Local configuration server May 09 17:50:33 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: running May 09 17:50:33 vol-office qobuz-connect[2381]: 20250509 17:50:33.850 [2381.2381] INFO SampleApp: shat down connection on UNIX socket May 09 17:50:33 vol-office systemd[1]: qobuz-connect.service: Succeeded. May 09 17:50:33 vol-office systemd[1]: Stopped Volumio Qobuz Connect Service. May 09 17:50:33 vol-office sudo[2890]: pam_unix(sudo:session): session closed for user root May 09 17:50:33 vol-office volumio[967]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 17:50:33 vol-office systemd[1]: Started Volumio Qobuz Connect Service. May 09 17:50:33 vol-office sudo[2896]: pam_unix(sudo:session): session closed for user root May 09 17:50:33 vol-office volumio[967]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 17:50:33 vol-office volumio[967]: info: CoreCommandRouter::getUIConfigOnPlugin May 09 17:50:33 vol-office volumio[967]: info: MPD Permissions set May 09 17:50:33 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: running May 09 17:50:33 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 09 17:50:33 vol-office volumio[967]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected May 09 17:50:33 vol-office volumio[967]: info: QobuzConnect: setDeactiveState invoked May 09 17:50:33 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:50:33 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:50:33 vol-office volumio[967]: info: Executing endpoint qc_getconfig May 09 17:50:33 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 09 17:50:33 vol-office qobuz-connect[2899]: 20250509 17:50:33.982 [2899.2899] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 09 17:50:33 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:50:33 vol-office qobuz-connect[2899]: 20250509 17:50:33.992 [2899.2899] INFO VolumeManager: [0x1a98910]: Setting new playback volume: 75 May 09 17:50:33 vol-office qobuz-connect[2899]: 20250509 17:50:33.992 [2899.2899] INFO VolumeManager: [0x1a98910]: Setting new mute state: 0 May 09 17:50:33 vol-office qobuz-connect[2899]: 20250509 17:50:33.992 [2899.2899] INFO QobuzConnect: [0x1a992e0]: Client initialized! May 09 17:50:33 vol-office qobuz-connect[2899]: 20250509 17:50:33.992 [2899.2899] INFO SampleApp: Starting Avahi advertising, name: vol-office, service name: _qobuz-connect._tcp May 09 17:50:34 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:50:34 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:50:34 vol-office qobuz-connect[2899]: 20250509 17:50:34.019 [2899.2899] INFO LocalConfigManager: [0x1a981f0]: Starting Local Configuration server May 09 17:50:34 vol-office qobuz-connect[2899]: 20250509 17:50:34.019 [2899.2899] INFO SampleApp: Starting Local configuration server May 09 17:50:34 vol-office qobuz-connect[2899]: 20250509 17:50:34.019 [2899.2899] INFO SampleApp: Connected to UNIX socket client 0x1a8df60 May 09 17:50:34 vol-office volumio[967]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 09 17:50:34 vol-office volumio[967]: info: QobuzConnect: QOBUZ Connect daemon connected May 09 17:50:34 vol-office volumio[967]: info: FusionDsp - May 09 17:50:34 vol-office qobuz-connect[2899]: 20250509 17:50:34.132 [2899.2899] INFO SampleApp: Playback volume changed: 75 May 09 17:50:34 vol-office volumio[967]: info: FusionDsp - Error: TypeError: Cannot read property 'split' of undefined May 09 17:50:34 vol-office volumio[967]: info: FusionDsp - May 09 17:50:34 vol-office volumio[967]: info: FusionDsp - Error: TypeError: Cannot read property 'split' of undefined May 09 17:50:34 vol-office volumio[967]: info: FusionDsp - May 09 17:50:34 vol-office volumio[967]: info: FusionDsp - Error: TypeError: Cannot read property 'split' of undefined May 09 17:50:34 vol-office volumio[967]: Configuration write error: Error: ENOENT: no such file or directory, open '/data/configuration/audio_interface/fusiondsp/config.json' May 09 17:50:34 vol-office volumio[967]: info: FusionDsp - undefined May 09 17:50:34 vol-office volumio[967]: info: FusionDsp - undefined May 09 17:50:34 vol-office volumio[967]: info: FusionDsp - undefined May 09 17:50:34 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:50:34 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:50:34 vol-office volumio[967]: info: Starting Shairport Sync May 09 17:50:34 vol-office sudo[2910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 09 17:50:34 vol-office sudo[2910]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:34 vol-office volumio[967]: error: Cannot write /etc/asound.conf: Error: ENOSPC: no space left on device, write May 09 17:50:34 vol-office volumio[967]: info: Output device has changed, restarting MPD May 09 17:50:34 vol-office systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 09 17:50:34 vol-office systemd[1]: shairport-sync.service: Succeeded. May 09 17:50:34 vol-office systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 09 17:50:34 vol-office sudo[2913]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 09 17:50:34 vol-office sudo[2913]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:34 vol-office volumio[967]: info: Output device has changed, restarting Shairport Sync May 09 17:50:34 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:50:34 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:50:34 vol-office systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 09 17:50:34 vol-office sudo[2913]: pam_unix(sudo:session): session closed for user root May 09 17:50:34 vol-office sudo[2910]: pam_unix(sudo:session): session closed for user root May 09 17:50:34 vol-office sudo[2917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 09 17:50:34 vol-office sudo[2917]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:35 vol-office systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 09 17:50:35 vol-office systemd[1]: mpd.service: Succeeded. May 09 17:50:35 vol-office systemd[1]: Stopped Music Player Daemon. May 09 17:50:35 vol-office systemd[1]: Starting Music Player Daemon... May 09 17:50:35 vol-office volumio[967]: xcb_connection_has_error() returned true May 09 17:50:35 vol-office volumio[967]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 09 17:50:35 vol-office volumio[967]: xcb_connection_has_error() returned true May 09 17:50:35 vol-office volumio[967]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 09 17:50:35 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:50:35 vol-office volumio[967]: info: QobuzConnect: setDeactiveState invoked May 09 17:50:35 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:50:35 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:50:35 vol-office sudo[2928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 09 17:50:35 vol-office sudo[2928]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:35 vol-office sudo[2930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 09 17:50:35 vol-office sudo[2930]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:35 vol-office sudo[2928]: pam_unix(sudo:session): session closed for user root May 09 17:50:35 vol-office sudo[2924]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 09 17:50:35 vol-office sudo[2924]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:35 vol-office sudo[2924]: pam_unix(sudo:session): session closed for user root May 09 17:50:35 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:50:35 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:50:35 vol-office volumio[967]: info: QobuzConnect: Setting Qobuz Connect card as outputdevice to 2 May 09 17:50:35 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: running May 09 17:50:35 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 09 17:50:35 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 09 17:50:35 vol-office sudo[2940]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect May 09 17:50:35 vol-office sudo[2940]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:35 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: running May 09 17:50:35 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 09 17:50:35 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: running May 09 17:50:35 vol-office volumio[967]: info: MPD Permissions set May 09 17:50:35 vol-office volumio[967]: info: Shairport-Sync Started May 09 17:50:35 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:50:35 vol-office qobuz-connect[2899]: 20250509 17:50:35.310 [2899.2899] INFO SampleApp: Stopping Local configuration server May 09 17:50:35 vol-office systemd[1]: Stopping Volumio Qobuz Connect Service... May 09 17:50:35 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 09 17:50:35 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:50:35 vol-office qobuz-connect[2899]: 20250509 17:50:35.321 [2899.2899] INFO SampleApp: shat down connection on UNIX socket May 09 17:50:35 vol-office systemd[1]: qobuz-connect.service: Succeeded. May 09 17:50:35 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: running May 09 17:50:35 vol-office volumio[967]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected May 09 17:50:35 vol-office systemd[1]: Stopped Volumio Qobuz Connect Service. May 09 17:50:35 vol-office sudo[2930]: pam_unix(sudo:session): session closed for user root May 09 17:50:35 vol-office volumio[967]: info: QobuzConnect: setDeactiveState invoked May 09 17:50:35 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:50:35 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:50:35 vol-office volumio[967]: info: Starting Shairport Sync May 09 17:50:35 vol-office systemd[1]: Started Volumio Qobuz Connect Service. May 09 17:50:35 vol-office sudo[2940]: pam_unix(sudo:session): session closed for user root May 09 17:50:35 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 09 17:50:35 vol-office sudo[2949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 09 17:50:35 vol-office sudo[2949]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:35 vol-office volumio[967]: info: Executing endpoint qc_getconfig May 09 17:50:35 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig May 09 17:50:35 vol-office qobuz-connect[2947]: 20250509 17:50:35.410 [2947.2947] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket May 09 17:50:35 vol-office volumio[967]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] May 09 17:50:35 vol-office volumio[967]: info: QobuzConnect: QOBUZ Connect daemon connected May 09 17:50:35 vol-office systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 09 17:50:35 vol-office systemd[1]: shairport-sync.service: Succeeded. May 09 17:50:35 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: running May 09 17:50:35 vol-office systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 09 17:50:35 vol-office qobuz-connect[2947]: 20250509 17:50:35.430 [2947.2947] INFO VolumeManager: [0x23cd910]: Setting new playback volume: 75 May 09 17:50:35 vol-office qobuz-connect[2947]: 20250509 17:50:35.431 [2947.2947] INFO VolumeManager: [0x23cd910]: Setting new mute state: 0 May 09 17:50:35 vol-office qobuz-connect[2947]: 20250509 17:50:35.431 [2947.2947] INFO QobuzConnect: [0x23ce2e0]: Client initialized! May 09 17:50:35 vol-office qobuz-connect[2947]: 20250509 17:50:35.432 [2947.2947] INFO SampleApp: Starting Avahi advertising, name: vol-office, service name: _qobuz-connect._tcp May 09 17:50:35 vol-office volumio[967]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 09 17:50:35 vol-office qobuz-connect[2947]: 20250509 17:50:35.448 [2947.2947] INFO LocalConfigManager: [0x23cd1f0]: Starting Local Configuration server May 09 17:50:35 vol-office qobuz-connect[2947]: 20250509 17:50:35.448 [2947.2947] INFO SampleApp: Starting Local configuration server May 09 17:50:35 vol-office qobuz-connect[2947]: 20250509 17:50:35.449 [2947.2947] INFO SampleApp: Connected to UNIX socket client 0x23c2f60 May 09 17:50:35 vol-office systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 09 17:50:35 vol-office sudo[2949]: pam_unix(sudo:session): session closed for user root May 09 17:50:35 vol-office volumio[967]: info: Shairport-Sync Started May 09 17:50:35 vol-office volumio[967]: (node:967) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit May 09 17:50:35 vol-office volumio[967]: (Use `node --trace-warnings ...` to show where the warning was created) May 09 17:50:35 vol-office volumio[967]: (node:967) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit May 09 17:50:35 vol-office volumio[967]: (node:967) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit May 09 17:50:35 vol-office volumio[967]: (node:967) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit May 09 17:50:35 vol-office volumio[967]: (node:967) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit May 09 17:50:35 vol-office qobuz-connect[2947]: 20250509 17:50:35.560 [2947.2947] INFO SampleApp: Playback volume changed: 75 May 09 17:50:35 vol-office volumio[967]: info: CoreCommandRouter::volumioGetState May 09 17:50:35 vol-office volumio[967]: info: CorePlayQueue::getTrack 0 May 09 17:50:35 vol-office volumio[967]: info: camilladsp service started and running in background, instance 1 May 09 17:50:35 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 09 17:50:35 vol-office volumio[967]: /bin/sh: 1: cannot create /data/configuration/audio_interface/fusiondsp/hwinfo.json: Directory nonexistent May 09 17:50:35 vol-office volumio[967]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json May 09 17:50:35 vol-office volumio[967]: /bin/sh: 1: cannot create /data/configuration/audio_interface/fusiondsp/hwinfo.json: Directory nonexistent May 09 17:50:35 vol-office volumio[967]: info: FusionDsp loaded May 09 17:50:35 vol-office volumio[967]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 09 17:50:35 vol-office sudo[2966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service May 09 17:50:35 vol-office sudo[2966]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 17:50:35 vol-office volumio[967]: info: FusionDsp - Reporting Fusion DSP Enabled May 09 17:50:35 vol-office volumio[967]: info: Adding Signal Path Element [object Object] May 09 17:50:35 vol-office volumio[967]: info: Adding fusiondspeq DSP Signal Path Element May 09 17:50:35 vol-office volumio[967]: info: FusionDsp - ---- installed callbackRead May 09 17:50:35 vol-office volumio[967]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 17:50:35 vol-office sudo[2966]: pam_unix(sudo:session): session closed for user root May 09 17:50:35 vol-office volumio[967]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp EACCES May 09 17:50:35 vol-office volumio[967]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) May 09 17:50:35 vol-office volumio[967]: at onErrorNT (internal/child_process.js:465:16) May 09 17:50:35 vol-office volumio[967]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { May 09 17:50:35 vol-office volumio[967]: errno: -13, May 09 17:50:35 vol-office volumio[967]: code: 'EACCES', May 09 17:50:35 vol-office volumio[967]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', May 09 17:50:35 vol-office volumio[967]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', May 09 17:50:35 vol-office volumio[967]: spawnargs: [ May 09 17:50:35 vol-office volumio[967]: '-p', May 09 17:50:35 vol-office volumio[967]: 9876, May 09 17:50:35 vol-office volumio[967]: '-o', May 09 17:50:35 vol-office volumio[967]: '/tmp/camilladsp.log', May 09 17:50:35 vol-office volumio[967]: '-l', May 09 17:50:35 vol-office volumio[967]: 'warn', May 09 17:50:35 vol-office volumio[967]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' May 09 17:50:35 vol-office volumio[967]: ] May 09 17:50:35 vol-office volumio[967]: } May 09 17:50:35 vol-office volumio[967]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 17:50:36 vol-office sudo[2977]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-09 17:49 May 09 17:50:36 vol-office sudo[2977]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 11:47:57 AM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fddd10196af80fdc784c726185a6abe4"