-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Thu 2025-12-11 12:30:28 CET. -- Dec 11 12:29:03 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:29:03 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:04 volumio volumio[880]: info: CoreCommandRouter::volumioGetQueue Dec 11 12:29:04 volumio volumio[880]: info: CoreStateMachine::getQueue Dec 11 12:29:04 volumio volumio[880]: info: CorePlayQueue::getQueue Dec 11 12:29:11 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:29:11 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:13 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 11 12:29:13 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 11 12:29:13 volumio volumio[880]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 11 12:29:23 volumio volumio[880]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 11 12:29:28 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:29:28 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:31 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 11 12:29:31 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 11 12:29:36 volumio volumio[880]: info: Starting Uninstall of plugin audio_interface - fusiondsp Dec 11 12:29:36 volumio volumio[880]: info: Uninstalling plugin fusiondsp Dec 11 12:29:36 volumio volumio[880]: info: Disabling plugin fusiondsp Dec 11 12:29:36 volumio volumio[880]: info: Preparing to generate the ALSA configuration file Dec 11 12:29:36 volumio volumio[880]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 11 12:29:36 volumio volumio[880]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 11 12:29:36 volumio volumio[880]: info: Reading ALSA contributions from plugins. Dec 11 12:29:36 volumio volumio[880]: info: Asound.conf file written Dec 11 12:29:36 volumio sudo[6512]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 11 12:29:36 volumio sudo[6512]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:36 volumio sudo[6512]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:36 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:29:36 volumio volumio[880]: No state is present for card b1 Dec 11 12:29:36 volumio volumio[880]: /usr/share/alsa/init/bcm2835:14: control element not found Dec 11 12:29:36 volumio volumio[880]: No state is present for card b1 Dec 11 12:29:36 volumio volumio[880]: No state is present for card Headphones Dec 11 12:29:36 volumio volumio[880]: /usr/share/alsa/init/bcm2835:20: control element not found Dec 11 12:29:36 volumio volumio[880]: No state is present for card Headphones Dec 11 12:29:36 volumio volumio[880]: No state is present for card BossDAC Dec 11 12:29:36 volumio volumio[880]: Found hardware: "BossDAC" "" "" "" "" Dec 11 12:29:36 volumio volumio[880]: Hardware is initialized using a generic method Dec 11 12:29:36 volumio volumio[880]: No state is present for card BossDAC Dec 11 12:29:36 volumio volumio[880]: info: Output device has changed, restarting MPD Dec 11 12:29:36 volumio sudo[6517]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 11 12:29:36 volumio sudo[6517]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:36 volumio sudo[6517]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:36 volumio volumio[880]: info: Output device has changed, restarting Shairport Sync Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:29:36 volumio sudo[6520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 11 12:29:36 volumio sudo[6520]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:36 volumio systemd[1]: Stopping Music Player Daemon... Dec 11 12:29:36 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:29:36 volumio volumio[880]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 12:29:36 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:29:36 volumio volumio[880]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:29:36 volumio systemd[1]: mpd.service: Succeeded. Dec 11 12:29:36 volumio systemd[1]: Stopped Music Player Daemon. Dec 11 12:29:36 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:29:36 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:36 volumio vtcs[6137]: [2025-12-11 12:29:36.206] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 11 12:29:36 volumio vtcs[6137]: [2025-12-11 12:29:36.206] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 11 12:29:36 volumio volumio[880]: info: Checking if uninstall.sh is present Dec 11 12:29:36 volumio systemd[1]: Starting Music Player Daemon... Dec 11 12:29:36 volumio sudo[6529]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:29:36 volumio sudo[6529]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:36 volumio sudo[6533]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:29:36 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Dec 11 12:29:36 volumio sudo[6529]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:36 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Dec 11 12:29:36 volumio sudo[6533]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:36 volumio systemd[1]: vtcs.service: Succeeded. Dec 11 12:29:36 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Dec 11 12:29:36 volumio sudo[6533]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:36 volumio sudo[6526]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 11 12:29:36 volumio sudo[6526]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:36 volumio volumio[880]: info: Executing uninstall.sh Dec 11 12:29:36 volumio sudo[6526]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:36 volumio sudo[6541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 11 12:29:36 volumio sudo[6541]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:36 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:29:36 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:29:36 volumio sudo[6541]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:36 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:29:36 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:29:36 volumio sudo[6548]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 11 12:29:36 volumio sudo[6548]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:36 volumio sudo[6547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh Dec 11 12:29:36 volumio volumio[880]: info: MPD Permissions set Dec 11 12:29:36 volumio sudo[6547]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:29:36 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 11 12:29:36 volumio qobuz-connect[6100]: 20251211 12:29:36.407 [6100.6100] INFO SampleApp: Stopping Local configuration server Dec 11 12:29:36 volumio qobuz-connect[6100]: 20251211 12:29:36.418 [6100.6100] INFO SampleApp: shat down connection on UNIX socket Dec 11 12:29:36 volumio systemd[1]: qobuz-connect.service: Succeeded. Dec 11 12:29:36 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:29:36 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:29:36 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:29:36 volumio volumio[880]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 11 12:29:36 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:29:36 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:36 volumio volumio[880]: info: Starting Shairport Sync Dec 11 12:29:36 volumio systemd[1]: Started Volumio Qobuz Connect Service. Dec 11 12:29:36 volumio sudo[6548]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:36 volumio sudo[6560]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 12:29:36 volumio sudo[6560]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:36 volumio sudo[6561]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /lib/systemd/system/fusiondsp.service Dec 11 12:29:36 volumio sudo[6561]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:36 volumio volumio[880]: info: Executing endpoint qc_getconfig Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 11 12:29:36 volumio qobuz-connect[6557]: 20251211 12:29:36.517 [6557.6557] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 11 12:29:36 volumio volumio[880]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 11 12:29:36 volumio volumio[880]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 11 12:29:36 volumio sudo[6561]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:36 volumio qobuz-connect[6557]: 20251211 12:29:36.523 [6557.6557] INFO VolumeManager: [0x12829e8]: Setting new playback volume: 75 Dec 11 12:29:36 volumio qobuz-connect[6557]: 20251211 12:29:36.523 [6557.6557] INFO VolumeManager: [0x12829e8]: Setting new mute state: 0 Dec 11 12:29:36 volumio qobuz-connect[6557]: 20251211 12:29:36.523 [6557.6557] INFO QobuzConnect: [0x12833b8]: Client initialized! Dec 11 12:29:36 volumio qobuz-connect[6557]: 20251211 12:29:36.523 [6557.6557] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 11 12:29:36 volumio qobuz-connect[6557]: 20251211 12:29:36.538 [6557.6557] INFO LocalConfigManager: [0x12822c8]: Starting Local Configuration server Dec 11 12:29:36 volumio qobuz-connect[6557]: 20251211 12:29:36.538 [6557.6557] INFO SampleApp: Starting Local configuration server Dec 11 12:29:36 volumio qobuz-connect[6557]: 20251211 12:29:36.538 [6557.6557] INFO SampleApp: Connected to UNIX socket client 0x1277f60 Dec 11 12:29:36 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 11 12:29:36 volumio sudo[6565]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Dec 11 12:29:36 volumio sudo[6565]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:36 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:29:36 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 11 12:29:36 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 11 12:29:36 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:29:36 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 11 12:29:36 volumio sudo[6560]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:36 volumio volumio[880]: info: Shairport-Sync Started Dec 11 12:29:36 volumio systemd[1]: Reloading. Dec 11 12:29:36 volumio qobuz-connect[6557]: 20251211 12:29:36.666 [6557.6557] INFO SampleApp: Playback volume changed: 75 Dec 11 12:29:36 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:29:36 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:36 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Dec 11 12:29:37 volumio mpd[6544]: Dec 11 12:29 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 11 12:29:37 volumio systemd[1]: Started Music Player Daemon. Dec 11 12:29:37 volumio sudo[6565]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:37 volumio sudo[6547]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:37 volumio sudo[6520]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:37 volumio volumio[880]: info: Uninstall script completed Dec 11 12:29:37 volumio volumio[880]: info: Removing plugin fusiondsp from configuration Dec 11 12:29:37 volumio volumio[880]: info: Successfully removed fusiondsp configuration files Dec 11 12:29:37 volumio volumio[880]: info: Plugin folders cleanup Dec 11 12:29:37 volumio volumio[880]: info: Scanning into folder /volumio/app/plugins/ Dec 11 12:29:37 volumio volumio[880]: info: Scanning category audio_interface Dec 11 12:29:37 volumio volumio[880]: info: Scanning category miscellanea Dec 11 12:29:37 volumio volumio[880]: info: Scanning category music_service Dec 11 12:29:37 volumio volumio[880]: info: Scanning category plugins.json Dec 11 12:29:37 volumio volumio[880]: info: Scanning category system_controller Dec 11 12:29:37 volumio volumio[880]: info: Scanning category user_interface Dec 11 12:29:37 volumio volumio[880]: info: Scanning into folder /data/plugins/ Dec 11 12:29:37 volumio volumio[880]: info: Scanning category audio_interface Dec 11 12:29:37 volumio volumio[880]: info: Cleaning folder for fusiondsp Dec 11 12:29:37 volumio volumio[880]: info: Scanning category music_service Dec 11 12:29:37 volumio volumio[880]: info: Scanning category user_interface Dec 11 12:29:37 volumio volumio[880]: info: Plugin folders cleanup completed Dec 11 12:29:37 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 11 12:29:37 volumio volumio[880]: info: [{"prettyName":"MotherEarthRadio","name":"motherearthradio","category":"music_service","version":"1.2.2","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Radio Paradise","name":"radio_paradise","category":"music_service","version":"1.0.14","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.3.0","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Peppy-meter-Basic","name":"peppymeterbasic","category":"user_interface","version":"0.0.3","icon":"fa-bar-chart","isManuallyInstalled":false,"enabled":true,"active":true}] Dec 11 12:29:37 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 11 12:29:37 volumio volumio[880]: error: updateQueue error: null Dec 11 12:29:39 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:29:39 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:29:39 volumio volumio[880]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:29:39 volumio volumio[880]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:29:39 volumio sudo[6613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 11 12:29:39 volumio sudo[6613]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:39 volumio systemd[1]: Started Volumio Tidal Connect Service. Dec 11 12:29:39 volumio sudo[6613]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:39 volumio volumio[880]: info: Executing endpoint tc_getconfig Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 11 12:29:39 volumio vtcs[6615]: STARTING TidalConnect services, version: 1.5.1-beta1 Dec 11 12:29:39 volumio vtcs[6615]: STARTED TidalConnect services. Dec 11 12:29:39 volumio volumio[880]: info: Executing endpoint tc_connect Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 11 12:29:39 volumio volumio[880]: info: Connecting to TidalConnect Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::servicePushState Dec 11 12:29:39 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:29:39 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:29:39 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:29:39 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:29:39 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:39 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:39 volumio volumio[880]: 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} Dec 11 12:29:39 volumio volumio[880]: verbose: CURRENT POSITION 0 Dec 11 12:29:39 volumio volumio[880]: info: CoreStateMachine::syncState stateService stop Dec 11 12:29:39 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus stop Dec 11 12:29:39 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:29:39 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:29:39 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:29:39 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:29:39 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:39 volumio volumio[880]: info: No code Dec 11 12:29:39 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:29:39 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:29:39 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:29:39 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:29:39 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::servicePushState Dec 11 12:29:39 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:29:39 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:29:39 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:29:39 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:29:39 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:39 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:39 volumio volumio[880]: 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} Dec 11 12:29:39 volumio volumio[880]: verbose: CURRENT POSITION 0 Dec 11 12:29:39 volumio volumio[880]: info: CoreStateMachine::syncState stateService stop Dec 11 12:29:39 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus stop Dec 11 12:29:39 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:29:39 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:29:39 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:29:39 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:29:39 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:39 volumio volumio[880]: info: No code Dec 11 12:29:39 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:29:39 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:29:39 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:29:39 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:29:39 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:29:39 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:39 volumio volumio[880]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 11 12:29:39 volumio volumio[880]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 11 12:29:39 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:29:39 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:29:39 volumio sudo[6635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:29:39 volumio sudo[6635]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:39 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:29:39 volumio sudo[6638]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:29:39 volumio sudo[6638]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:39 volumio sudo[6635]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:39 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:29:39 volumio sudo[6641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:29:39 volumio sudo[6641]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:39 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:29:39 volumio sudo[6644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:29:39 volumio sudo[6638]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:39 volumio sudo[6644]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:39 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:29:39 volumio sudo[6647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:29:39 volumio sudo[6647]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:39 volumio sudo[6641]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:39 volumio sudo[6644]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:39 volumio sudo[6649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:29:39 volumio sudo[6649]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:29:39 volumio sudo[6647]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:39 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:29:39 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:29:39 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:29:39 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:29:39 volumio sudo[6649]: pam_unix(sudo:session): session closed for user root Dec 11 12:29:39 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:29:42 volumio volumio[880]: info: TidalConnect service started! Dec 11 12:29:47 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:29:47 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:29:52 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 11 12:29:52 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 11 12:29:55 volumio volumio[880]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Dec 11 12:29:58 volumio volumio[880]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Dec 11 12:29:58 volumio volumio[880]: info: Folder /tmp/plugins removed Dec 11 12:29:58 volumio volumio[880]: info: Check plugin dependencies Dec 11 12:29:58 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 11 12:29:58 volumio volumio[880]: info: Checking if plugin already exists Dec 11 12:29:58 volumio volumio[880]: info: Rename folder Dec 11 12:29:58 volumio volumio[880]: info: Folder /tmp/downloaded_plugin.zip removed Dec 11 12:29:58 volumio volumio[880]: info: Move to category Dec 11 12:30:00 volumio volumio[880]: info: Checking if install.sh is present Dec 11 12:30:00 volumio volumio[880]: info: Executing install.sh Dec 11 12:30:00 volumio sudo[6701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Dec 11 12:30:00 volumio sudo[6701]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:00 volumio volumio[880]: info: creating filters folder and copying demo filters Dec 11 12:30:00 volumio volumio[880]: info: copying demo flters Dec 11 12:30:00 volumio volumio[880]: info: ./presets/ Dec 11 12:30:00 volumio volumio[880]: info: ./presets/2XEQ15/ Dec 11 12:30:00 volumio volumio[880]: info: ./presets/2XEQ15/.Bass-FusionDsp.json Dec 11 12:30:00 volumio volumio[880]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json Dec 11 12:30:00 volumio volumio[880]: info: ./presets/2XEQ15/.Classic-FusionDsp.json Dec 11 12:30:00 volumio volumio[880]: info: ./presets/2XEQ15/.Voice-FusionDsp.json Dec 11 12:30:00 volumio sudo[6726]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update Dec 11 12:30:00 volumio sudo[6726]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:00 volumio volumio[880]: info: ./presets/2XEQ15/.Rock-FusionDsp.json Dec 11 12:30:00 volumio volumio[880]: info: ./presets/PEQ/ Dec 11 12:30:00 volumio volumio[880]: info: ./presets/convfir/ Dec 11 12:30:00 volumio volumio[880]: info: ./presets/convfir/kef.json Dec 11 12:30:00 volumio volumio[880]: info: ./presets/convfir/test.json Dec 11 12:30:00 volumio volumio[880]: info: ./presets/EQ15/ Dec 11 12:30:00 volumio volumio[880]: info: ./presets/EQ15/.Bass-FusionDsp.json Dec 11 12:30:00 volumio volumio[880]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json Dec 11 12:30:00 volumio volumio[880]: info: ./presets/EQ15/.Classic-FusionDsp.json Dec 11 12:30:00 volumio volumio[880]: info: ./presets/EQ15/.Voice-FusionDsp.json Dec 11 12:30:00 volumio volumio[880]: info: ./presets/EQ15/.Rock-FusionDsp.json Dec 11 12:30:00 volumio volumio[880]: info: Installing/fusiondsp dependencies Dec 11 12:30:01 volumio volumio[880]: info: Ign:1 http://raspbian.raspberrypi.org/raspbian buster InRelease Dec 11 12:30:01 volumio volumio[880]: info: Hit:2 http://archive.raspberrypi.org/debian buster InRelease Dec 11 12:30:01 volumio volumio[880]: info: Hit:3 https://deb.nodesource.com/node_14.x buster InRelease Dec 11 12:30:01 volumio volumio[880]: info: Err:4 http://raspbian.raspberrypi.org/raspbian buster Release Dec 11 12:30:01 volumio volumio[880]: info: 404 Not Found [IP: 93.93.128.193 80] Dec 11 12:30:01 volumio volumio[880]: info: Reading package lists... Dec 11 12:30:01 volumio sudo[6726]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:01 volumio sudo[6864]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Dec 11 12:30:01 volumio sudo[6864]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:01 volumio volumio[880]: info: Reading package lists... Dec 11 12:30:01 volumio volumio[880]: info: Building dependency tree... Dec 11 12:30:01 volumio volumio[880]: info: Reading state information... Dec 11 12:30:01 volumio sudo[6864]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:01 volumio sudo[6868]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Dec 11 12:30:01 volumio sudo[6868]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:01 volumio volumio[880]: info: lib/systemd/system/fusiondsp.service Dec 11 12:30:01 volumio sudo[6868]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:03 volumio volumio[880]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Dec 11 12:30:03 volumio volumio[880]: info: more info at http://www.winimage.com/zLibDll/unzip.html Dec 11 12:30:03 volumio volumio[880]: info: Dec 11 12:30:03 volumio volumio[880]: info: cgui-1.0.0.zip opened Dec 11 12:30:03 volumio volumio[880]: info: creating directory: cgui/ Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/LICENSE.txt Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/README.md Dec 11 12:30:03 volumio volumio[880]: info: creating directory: cgui/build/ Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/robots.txt Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/logo512.png Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/asset-manifest.json Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/index.html Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/.put_statics_here Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/favicon.ico Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/logo192.png Dec 11 12:30:03 volumio sudo[6872]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Dec 11 12:30:03 volumio sudo[6872]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/manifest.json Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/css-variables.css Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/service-worker.js Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Dec 11 12:30:03 volumio volumio[880]: info: creating directory: cgui/build/static/ Dec 11 12:30:03 volumio volumio[880]: info: creating directory: cgui/build/static/css/ Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/css/main.1503f6cd.css Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Dec 11 12:30:03 volumio sudo[6872]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:03 volumio volumio[880]: info: creating directory: cgui/build/static/media/ Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Dec 11 12:30:03 volumio volumio[880]: info: creating directory: cgui/build/static/js/ Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/js/main.71e11955.js Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/js/main.71e11955.js.map Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Dec 11 12:30:03 volumio volumio[880]: info: creating directory: cgui/config/ Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/config/camillagui.yml Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/config/gui-config.yml Dec 11 12:30:03 volumio volumio[880]: info: creating directory: cgui/backend/ Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/filters_test.py Dec 11 12:30:03 volumio sudo[6874]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/version.py Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/filters.py Dec 11 12:30:03 volumio sudo[6874]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/settings.py Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/views.py Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/filterdefaults.py Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/__init__.py Dec 11 12:30:03 volumio volumio[880]: info: creating directory: cgui/backend/__pycache__/ Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/routes.py Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/backend/filemanagement.py Dec 11 12:30:03 volumio volumio[880]: info: extracting: cgui/main.py Dec 11 12:30:03 volumio sudo[6874]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:03 volumio sudo[6876]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Dec 11 12:30:03 volumio sudo[6876]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:03 volumio sudo[6876]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:04 volumio volumio[880]: info: copying hw detection script Dec 11 12:30:04 volumio volumio[880]: info: Detected cpu architecture as armv7l Dec 11 12:30:05 volumio volumio[880]: info: Tunnel connection is inactive, restarting it Dec 11 12:30:05 volumio volumio[880]: info: Starting Tunnel 1 Dec 11 12:30:05 volumio volumio[880]: info: Starting Tunnel Connection Checker Dec 11 12:30:06 volumio sudo[6895]: 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 Dec 11 12:30:06 volumio sudo[6895]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:06 volumio sudo[6895]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:06 volumio sudo[6897]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Dec 11 12:30:06 volumio sudo[6897]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:06 volumio sudo[6897]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:06 volumio sudo[6899]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Dec 11 12:30:06 volumio sudo[6899]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:06 volumio volumio[880]: info: Reading package lists... Dec 11 12:30:06 volumio volumio[880]: info: Building dependency tree... Dec 11 12:30:06 volumio volumio[880]: info: Reading state information... Dec 11 12:30:06 volumio sudo[6899]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:06 volumio volumio[880]: Plugin install end detected on script Dec 11 12:30:06 volumio sudo[6701]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:06 volumio volumio[880]: info: Install script completed Dec 11 12:30:06 volumio volumio[880]: info: Adding reference to registry Dec 11 12:30:06 volumio volumio[880]: info: Done installing plugin. Dec 11 12:30:06 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 11 12:30:06 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 11 12:30:06 volumio volumio[880]: info: Folder /tmp/plugins removed Dec 11 12:30:06 volumio volumio[880]: info: Folder /tmp/downloaded_plugin.zip removed Dec 11 12:30:06 volumio volumio[880]: info: Folder /data/temp removed Dec 11 12:30:09 volumio volumio[880]: info: Enabling plugin fusiondsp Dec 11 12:30:09 volumio volumio[880]: info: Loading plugin "fusiondsp"... Dec 11 12:30:09 volumio volumio[880]: info: Preparing to generate the ALSA configuration file Dec 11 12:30:09 volumio volumio[880]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 11 12:30:09 volumio volumio[880]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 11 12:30:09 volumio volumio[880]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 11 12:30:09 volumio volumio[880]: info: Reading ALSA contributions from plugins. Dec 11 12:30:09 volumio volumio[880]: info: Asound.conf file written Dec 11 12:30:09 volumio sudo[6918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Dec 11 12:30:09 volumio sudo[6918]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:09 volumio sudo[6918]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:09 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:09 volumio volumio[880]: No state is present for card b1 Dec 11 12:30:09 volumio volumio[880]: /usr/share/alsa/init/bcm2835:14: control element not found Dec 11 12:30:09 volumio volumio[880]: No state is present for card b1 Dec 11 12:30:09 volumio volumio[880]: No state is present for card Headphones Dec 11 12:30:09 volumio volumio[880]: /usr/share/alsa/init/bcm2835:20: control element not found Dec 11 12:30:09 volumio volumio[880]: No state is present for card Headphones Dec 11 12:30:09 volumio volumio[880]: No state is present for card BossDAC Dec 11 12:30:09 volumio volumio[880]: Found hardware: "BossDAC" "" "" "" "" Dec 11 12:30:09 volumio volumio[880]: Hardware is initialized using a generic method Dec 11 12:30:09 volumio volumio[880]: No state is present for card BossDAC Dec 11 12:30:09 volumio volumio[880]: info: Output device has changed, restarting MPD Dec 11 12:30:09 volumio sudo[6923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 11 12:30:09 volumio sudo[6923]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:09 volumio volumio[880]: info: Output device has changed, restarting Shairport Sync Dec 11 12:30:09 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:09 volumio sudo[6923]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:09 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:09 volumio sudo[6926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 11 12:30:09 volumio sudo[6926]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:09 volumio systemd[1]: Stopping Music Player Daemon... Dec 11 12:30:09 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:09 volumio volumio[880]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 12:30:09 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:09 volumio volumio[880]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 11 12:30:09 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:09 volumio systemd[1]: mpd.service: Succeeded. Dec 11 12:30:09 volumio systemd[1]: Stopped Music Player Daemon. Dec 11 12:30:09 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:09 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:09 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:09 volumio vtcs[6615]: [2025-12-11 12:30:09.849] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 11 12:30:09 volumio vtcs[6615]: [2025-12-11 12:30:09.849] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 11 12:30:09 volumio sudo[6935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:09 volumio volumio[880]: info: PLUGIN START: fusiondsp Dec 11 12:30:09 volumio volumio[880]: info: Loading i18n strings for locale it Dec 11 12:30:09 volumio volumio[880]: info: Plugin peppymeterbasic has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Dec 11 12:30:09 volumio volumio[880]: info: Plugin peppymeterbasic has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Dec 11 12:30:09 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 11 12:30:09 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:09 volumio volumio[880]: info: FusionDsp - mixtype--------------------- Hardware Dec 11 12:30:09 volumio volumio[880]: info: Preparing to generate the ALSA configuration file Dec 11 12:30:09 volumio volumio[880]: info: Done. Dec 11 12:30:09 volumio sudo[6935]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:09 volumio systemd[1]: Starting Music Player Daemon... Dec 11 12:30:09 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Dec 11 12:30:09 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Dec 11 12:30:09 volumio systemd[1]: vtcs.service: Succeeded. Dec 11 12:30:09 volumio sudo[6938]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:09 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Dec 11 12:30:09 volumio sudo[6938]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:09 volumio sudo[6935]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:09 volumio volumio[880]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 11 12:30:09 volumio volumio[880]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 11 12:30:09 volumio volumio[880]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 11 12:30:09 volumio sudo[6938]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:09 volumio volumio[880]: info: Reading ALSA contributions from plugins. Dec 11 12:30:09 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:09 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:09 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:09 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:09 volumio sudo[6945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 11 12:30:09 volumio sudo[6945]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:09 volumio volumio[880]: info: MPD Permissions set Dec 11 12:30:09 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:09 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:09 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:09 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:09 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:09 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:09 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:09 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:09 volumio sudo[6945]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:09 volumio sudo[6931]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 11 12:30:09 volumio sudo[6931]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:10 volumio sudo[6931]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:10 volumio sudo[6949]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 11 12:30:10 volumio sudo[6949]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:10 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:10 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:10 volumio volumio[880]: info: Starting Shairport Sync Dec 11 12:30:10 volumio volumio[880]: info: Asound.conf file unchanged, so no further update is needed Dec 11 12:30:10 volumio volumio[880]: info: Output device has changed, restarting MPD Dec 11 12:30:10 volumio volumio[880]: info: Output device has changed, restarting Shairport Sync Dec 11 12:30:10 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:10 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:10 volumio sudo[6958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 12:30:10 volumio sudo[6958]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:10 volumio sudo[6961]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 11 12:30:10 volumio sudo[6961]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:10 volumio sudo[6961]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:10 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 11 12:30:10 volumio qobuz-connect[6557]: 20251211 12:30:10.102 [6557.6557] INFO SampleApp: Stopping Local configuration server Dec 11 12:30:10 volumio sudo[6964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 11 12:30:10 volumio sudo[6964]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 11 12:30:10 volumio qobuz-connect[6557]: 20251211 12:30:10.113 [6557.6557] INFO SampleApp: shat down connection on UNIX socket Dec 11 12:30:10 volumio systemd[1]: qobuz-connect.service: Succeeded. Dec 11 12:30:10 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 11 12:30:10 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 11 12:30:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 11 12:30:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 11 12:30:10 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:10 volumio volumio[880]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 12:30:10 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:10 volumio volumio[880]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 11 12:30:10 volumio sudo[6958]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:10 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:10 volumio systemd[1]: Started Volumio Qobuz Connect Service. Dec 11 12:30:10 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 11 12:30:10 volumio systemd[1]: mpd.service: Succeeded. Dec 11 12:30:10 volumio systemd[1]: Stopped Music Player Daemon. Dec 11 12:30:10 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:10 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:10 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:10 volumio sudo[6949]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:10 volumio systemd[1]: Starting Music Player Daemon... Dec 11 12:30:10 volumio sudo[6978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:10 volumio sudo[6978]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:10 volumio sudo[6981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:10 volumio sudo[6981]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:10 volumio sudo[6978]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:10 volumio sudo[6974]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 11 12:30:10 volumio sudo[6974]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:10 volumio sudo[6974]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:10 volumio sudo[6981]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:10 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:10 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:10 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:10 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:10 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:10 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:10 volumio sudo[6990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 11 12:30:10 volumio sudo[6990]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:10 volumio qobuz-connect[6970]: 20251211 12:30:10.305 [6970.6970] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 11 12:30:10 volumio qobuz-connect[6970]: 20251211 12:30:10.309 [6970.6970] INFO VolumeManager: [0x1b2d9e8]: Setting new playback volume: 75 Dec 11 12:30:10 volumio qobuz-connect[6970]: 20251211 12:30:10.309 [6970.6970] INFO VolumeManager: [0x1b2d9e8]: Setting new mute state: 0 Dec 11 12:30:10 volumio qobuz-connect[6970]: 20251211 12:30:10.309 [6970.6970] INFO QobuzConnect: [0x1b2e3b8]: Client initialized! Dec 11 12:30:10 volumio qobuz-connect[6970]: 20251211 12:30:10.309 [6970.6970] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 11 12:30:10 volumio qobuz-connect[6970]: 20251211 12:30:10.315 [6970.6970] INFO LocalConfigManager: [0x1b2d2c8]: Starting Local Configuration server Dec 11 12:30:10 volumio qobuz-connect[6970]: 20251211 12:30:10.315 [6970.6970] INFO SampleApp: Starting Local configuration server Dec 11 12:30:10 volumio qobuz-connect[6970]: 20251211 12:30:10.315 [6970.6970] INFO SampleApp: Connected to UNIX socket client 0x1b22f60 Dec 11 12:30:10 volumio volumio[880]: info: MPD Permissions set Dec 11 12:30:10 volumio volumio[880]: info: Shairport-Sync Started Dec 11 12:30:10 volumio volumio[880]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 11 12:30:10 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:10 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:10 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:10 volumio volumio[880]: info: Executing endpoint qc_getconfig Dec 11 12:30:10 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 11 12:30:10 volumio volumio[880]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 11 12:30:10 volumio volumio[880]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 11 12:30:10 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:10 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:10 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:10 volumio volumio[880]: info: Starting Shairport Sync Dec 11 12:30:10 volumio sudo[7000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 12:30:10 volumio sudo[7000]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:10 volumio sudo[6990]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 11 12:30:10 volumio sudo[7002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 11 12:30:10 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:10 volumio sudo[7002]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:10 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 11 12:30:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 11 12:30:10 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 11 12:30:10 volumio sudo[7000]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:10 volumio volumio[880]: info: Shairport-Sync Started Dec 11 12:30:10 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 11 12:30:10 volumio qobuz-connect[6970]: 20251211 12:30:10.427 [6970.6970] INFO SampleApp: Stopping Local configuration server Dec 11 12:30:10 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:10 volumio qobuz-connect[6970]: 20251211 12:30:10.438 [6970.6970] INFO SampleApp: shat down connection on UNIX socket Dec 11 12:30:10 volumio volumio[880]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 11 12:30:10 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:10 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:10 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:10 volumio systemd[1]: qobuz-connect.service: Succeeded. Dec 11 12:30:10 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 11 12:30:10 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:10 volumio systemd[1]: Started Volumio Qobuz Connect Service. Dec 11 12:30:10 volumio sudo[7002]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:10 volumio volumio[880]: info: Executing endpoint qc_getconfig Dec 11 12:30:10 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 11 12:30:10 volumio qobuz-connect[7006]: 20251211 12:30:10.489 [7006.7006] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 11 12:30:10 volumio volumio[880]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 11 12:30:10 volumio volumio[880]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 11 12:30:10 volumio qobuz-connect[7006]: 20251211 12:30:10.493 [7006.7006] INFO VolumeManager: [0x17369e8]: Setting new playback volume: 75 Dec 11 12:30:10 volumio qobuz-connect[7006]: 20251211 12:30:10.493 [7006.7006] INFO VolumeManager: [0x17369e8]: Setting new mute state: 0 Dec 11 12:30:10 volumio qobuz-connect[7006]: 20251211 12:30:10.493 [7006.7006] INFO QobuzConnect: [0x17373b8]: Client initialized! Dec 11 12:30:10 volumio qobuz-connect[7006]: 20251211 12:30:10.493 [7006.7006] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 11 12:30:10 volumio qobuz-connect[7006]: 20251211 12:30:10.501 [7006.7006] INFO LocalConfigManager: [0x17362c8]: Starting Local Configuration server Dec 11 12:30:10 volumio qobuz-connect[7006]: 20251211 12:30:10.501 [7006.7006] INFO SampleApp: Starting Local configuration server Dec 11 12:30:10 volumio qobuz-connect[7006]: 20251211 12:30:10.501 [7006.7006] INFO SampleApp: Connected to UNIX socket client 0x172bf60 Dec 11 12:30:10 volumio sudo[7011]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Dec 11 12:30:10 volumio sudo[7011]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:10 volumio autossh[5745]: received signal to exit (15) Dec 11 12:30:10 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:10 volumio systemd[1]: Stopping MyVolumio SSH Tunnel... Dec 11 12:30:10 volumio systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Dec 11 12:30:10 volumio systemd[1]: sshtunnel.service: Succeeded. Dec 11 12:30:10 volumio systemd[1]: Stopped MyVolumio SSH Tunnel. Dec 11 12:30:10 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:10 volumio qobuz-connect[7006]: 20251211 12:30:10.638 [7006.7006] INFO SampleApp: Playback volume changed: 75 Dec 11 12:30:10 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:10 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:10 volumio systemd[1]: Started MyVolumio SSH Tunnel. Dec 11 12:30:10 volumio sudo[7011]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:10 volumio volumio[880]: info: Remote SSH Started Dec 11 12:30:10 volumio autossh[7014]: port set to 0, monitoring disabled Dec 11 12:30:10 volumio autossh[7014]: starting ssh (count 1) Dec 11 12:30:10 volumio autossh[7014]: ssh child pid is 7017 Dec 11 12:30:10 volumio volumio[880]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 11 12:30:10 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:10 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:11 volumio mpd[6989]: Dec 11 12:30 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 11 12:30:11 volumio systemd[1]: Started Music Player Daemon. Dec 11 12:30:11 volumio sudo[6926]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:11 volumio sudo[6964]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:11 volumio volumio[880]: error: MPD error: The expression evaluated to a falsy value: Dec 11 12:30:11 volumio volumio[880]: assert.ok(self.idling) Dec 11 12:30:11 volumio volumio[880]: error: The expression evaluated to a falsy value: Dec 11 12:30:11 volumio volumio[880]: assert.ok(self.idling) Dec 11 12:30:11 volumio volumio[880]: error: updateQueue error: null Dec 11 12:30:11 volumio volumio[880]: info: camilladsp service started and running in background, instance 1 Dec 11 12:30:11 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:11 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:11 volumio volumio[880]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 384000 <-AAAAAAAAAAAAA Dec 11 12:30:11 volumio volumio[880]: info: FusionDsp loaded Dec 11 12:30:11 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 11 12:30:11 volumio sudo[7033]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Dec 11 12:30:11 volumio sudo[7033]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:11 volumio volumio[880]: info: FusionDsp - Reporting Fusion DSP Enabled Dec 11 12:30:11 volumio volumio[880]: info: Adding Signal Path Element [object Object] Dec 11 12:30:11 volumio volumio[880]: info: Adding fusiondspeq DSP Signal Path Element Dec 11 12:30:12 volumio volumio[880]: info: FusionDsp - ---- installed callbackRead Dec 11 12:30:12 volumio volumio[880]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 11 12:30:12 volumio volumio[880]: error: FusionDsp - WebSocket error: [object Object] Dec 11 12:30:12 volumio volumio[880]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 11 12:30:12 volumio systemd[1]: Started FusionDsp Daemon. Dec 11 12:30:12 volumio sudo[7033]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:12 volumio volumio[7035]: Traceback (most recent call last): Dec 11 12:30:12 volumio volumio[7035]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 11 12:30:12 volumio volumio[7035]: from aiohttp import web Dec 11 12:30:12 volumio volumio[7035]: ModuleNotFoundError: No module named 'aiohttp' Dec 11 12:30:12 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 11 12:30:12 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 11 12:30:12 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:12 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:13 volumio volumio[880]: 0+0 records in Dec 11 12:30:13 volumio volumio[880]: 0+0 records out Dec 11 12:30:13 volumio volumio[880]: 0 bytes copied, 0.000100483 s, 0.0 kB/s Dec 11 12:30:13 volumio volumio[880]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:13 volumio volumio[880]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:13 volumio sudo[7054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 11 12:30:13 volumio sudo[7054]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:13 volumio systemd[1]: Started Volumio Tidal Connect Service. Dec 11 12:30:13 volumio sudo[7054]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:13 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:13 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:13 volumio volumio[880]: info: Executing endpoint tc_getconfig Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 11 12:30:13 volumio vtcs[7056]: STARTING TidalConnect services, version: 1.5.1-beta1 Dec 11 12:30:13 volumio vtcs[7056]: STARTED TidalConnect services. Dec 11 12:30:13 volumio volumio[880]: info: Executing endpoint tc_connect Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 11 12:30:13 volumio volumio[880]: info: Connecting to TidalConnect Dec 11 12:30:13 volumio volumio[880]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:13 volumio volumio[880]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::servicePushState Dec 11 12:30:13 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:30:13 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:30:13 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:30:13 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:13 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:13 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:13 volumio volumio[880]: 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} Dec 11 12:30:13 volumio volumio[880]: verbose: CURRENT POSITION 0 Dec 11 12:30:13 volumio volumio[880]: info: CoreStateMachine::syncState stateService stop Dec 11 12:30:13 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus stop Dec 11 12:30:13 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:30:13 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:30:13 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:30:13 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:13 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:13 volumio volumio[880]: info: No code Dec 11 12:30:13 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:30:13 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:30:13 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:30:13 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:13 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::servicePushState Dec 11 12:30:13 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:30:13 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:30:13 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:30:13 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:13 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:13 volumio volumio[880]: 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} Dec 11 12:30:13 volumio volumio[880]: verbose: CURRENT POSITION 0 Dec 11 12:30:13 volumio volumio[880]: info: CoreStateMachine::syncState stateService stop Dec 11 12:30:13 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus stop Dec 11 12:30:13 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:30:13 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:30:13 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:30:13 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:13 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:13 volumio volumio[880]: info: No code Dec 11 12:30:13 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:30:13 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:30:13 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:30:13 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:30:13 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:13 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:13 volumio volumio[880]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 11 12:30:13 volumio volumio[880]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 11 12:30:13 volumio volumio[880]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 11 12:30:13 volumio volumio[880]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 11 12:30:13 volumio volumio[880]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 11 12:30:13 volumio volumio[880]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 11 12:30:13 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:30:13 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:30:13 volumio sudo[7085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:30:13 volumio sudo[7085]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:13 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:30:13 volumio sudo[7088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:30:13 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:30:13 volumio sudo[7085]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:13 volumio sudo[7088]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:13 volumio sudo[7090]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:30:13 volumio sudo[7090]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:13 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:30:13 volumio sudo[7094]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:30:13 volumio sudo[7094]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:13 volumio sudo[7088]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:13 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:30:13 volumio sudo[7097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:30:13 volumio sudo[7097]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:13 volumio sudo[7090]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:13 volumio sudo[7100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:30:13 volumio sudo[7094]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:13 volumio sudo[7100]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:13 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:13 volumio sudo[7097]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:13 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:30:13 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:30:13 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:30:13 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:30:13 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:30:13 volumio sudo[7100]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:13 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:30:13 volumio sudo[7103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 11 12:30:13 volumio sudo[7103]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:13 volumio sudo[7103]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:14 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 11 12:30:14 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1. Dec 11 12:30:14 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 11 12:30:14 volumio systemd[1]: Started FusionDsp Daemon. Dec 11 12:30:14 volumio volumio[7106]: Traceback (most recent call last): Dec 11 12:30:14 volumio volumio[7106]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 11 12:30:14 volumio volumio[7106]: from aiohttp import web Dec 11 12:30:14 volumio volumio[7106]: ModuleNotFoundError: No module named 'aiohttp' Dec 11 12:30:14 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 11 12:30:14 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 11 12:30:15 volumio volumio[880]: info: Enabling plugin fusiondsp Dec 11 12:30:15 volumio volumio[880]: info: Loading plugin "fusiondsp"... Dec 11 12:30:15 volumio volumio[880]: info: Applying required configuration parameters for plugin fusiondsp Dec 11 12:30:15 volumio volumio[880]: info: Preparing to generate the ALSA configuration file Dec 11 12:30:15 volumio volumio[880]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 11 12:30:15 volumio volumio[880]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 11 12:30:15 volumio volumio[880]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 11 12:30:15 volumio volumio[880]: info: Reading ALSA contributions from plugins. Dec 11 12:30:15 volumio volumio[880]: info: Asound.conf file unchanged, so no further update is needed Dec 11 12:30:15 volumio volumio[880]: info: Output device has changed, restarting MPD Dec 11 12:30:15 volumio sudo[7108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 11 12:30:15 volumio sudo[7108]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:15 volumio sudo[7108]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:15 volumio volumio[880]: info: Output device has changed, restarting Shairport Sync Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:15 volumio sudo[7111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 11 12:30:15 volumio sudo[7111]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:15 volumio systemd[1]: Stopping Music Player Daemon... Dec 11 12:30:15 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:15 volumio volumio[880]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 12:30:15 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:15 volumio volumio[880]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:15 volumio systemd[1]: mpd.service: Succeeded. Dec 11 12:30:15 volumio systemd[1]: Stopped Music Player Daemon. Dec 11 12:30:15 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:15 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:15 volumio vtcs[7056]: [2025-12-11 12:30:15.747] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Dec 11 12:30:15 volumio vtcs[7056]: [2025-12-11 12:30:15.747] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Dec 11 12:30:15 volumio volumio[880]: info: PLUGIN START: fusiondsp Dec 11 12:30:15 volumio volumio[880]: info: Loading i18n strings for locale it Dec 11 12:30:15 volumio volumio[880]: info: Plugin peppymeterbasic has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Dec 11 12:30:15 volumio volumio[880]: info: Plugin peppymeterbasic has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:15 volumio volumio[880]: info: FusionDsp - mixtype--------------------- Hardware Dec 11 12:30:15 volumio volumio[880]: info: Preparing to generate the ALSA configuration file Dec 11 12:30:15 volumio volumio[880]: info: Done. Dec 11 12:30:15 volumio systemd[1]: Starting Music Player Daemon... Dec 11 12:30:15 volumio sudo[7120]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:15 volumio sudo[7120]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:15 volumio sudo[7123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:15 volumio sudo[7123]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:15 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Dec 11 12:30:15 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Dec 11 12:30:15 volumio systemd[1]: vtcs.service: Succeeded. Dec 11 12:30:15 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Dec 11 12:30:15 volumio sudo[7129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 11 12:30:15 volumio sudo[7129]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:15 volumio sudo[7120]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:15 volumio sudo[7123]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:15 volumio sudo[7129]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:15 volumio volumio[880]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 11 12:30:15 volumio volumio[880]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 11 12:30:15 volumio volumio[880]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 11 12:30:15 volumio volumio[880]: info: Reading ALSA contributions from plugins. Dec 11 12:30:15 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:15 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:15 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:15 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:15 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:15 volumio sudo[7133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 11 12:30:15 volumio sudo[7133]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:15 volumio volumio[880]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Dec 11 12:30:15 volumio volumio[880]: info: MPD Permissions set Dec 11 12:30:15 volumio sudo[7116]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 11 12:30:15 volumio sudo[7116]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:15 volumio sudo[7116]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:15 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:15 volumio volumio[880]: info: Starting Shairport Sync Dec 11 12:30:15 volumio qobuz-connect[7006]: 20251211 12:30:15.962 [7006.7006] INFO SampleApp: Stopping Local configuration server Dec 11 12:30:15 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 11 12:30:15 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:15 volumio volumio[880]: info: Asound.conf file unchanged, so no further update is needed Dec 11 12:30:15 volumio volumio[880]: info: Output device has changed, restarting MPD Dec 11 12:30:15 volumio qobuz-connect[7006]: 20251211 12:30:15.977 [7006.7006] INFO SampleApp: shat down connection on UNIX socket Dec 11 12:30:15 volumio sudo[7142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 12:30:15 volumio sudo[7142]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:15 volumio systemd[1]: qobuz-connect.service: Succeeded. Dec 11 12:30:15 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 11 12:30:15 volumio systemd[1]: Started Volumio Qobuz Connect Service. Dec 11 12:30:16 volumio sudo[7133]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio volumio[880]: info: Output device has changed, restarting Shairport Sync Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 11 12:30:16 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 11 12:30:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 11 12:30:16 volumio sudo[7146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 11 12:30:16 volumio sudo[7146]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 11 12:30:16 volumio sudo[7146]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio sudo[7142]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio sudo[7148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 11 12:30:16 volumio sudo[7148]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 11 12:30:16 volumio systemd[1]: mpd.service: Succeeded. Dec 11 12:30:16 volumio systemd[1]: Stopped Music Player Daemon. Dec 11 12:30:16 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:16 volumio volumio[880]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 12:30:16 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:16 volumio volumio[880]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio systemd[1]: Starting Music Player Daemon... Dec 11 12:30:16 volumio volumiossh-tunnel[7013]: Warning: Permanently added '[eu5.myvolumio.org]:2222,[185.14.184.111]:2222' (RSA) to the list of known hosts. Dec 11 12:30:16 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:16 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:16 volumio volumio[880]: info: Preparing to generate the ALSA configuration file Dec 11 12:30:16 volumio sudo[7162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:16 volumio sudo[7162]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio sudo[7157]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 11 12:30:16 volumio sudo[7157]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio sudo[7157]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio sudo[7166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:16 volumio sudo[7166]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio sudo[7162]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio sudo[7166]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio volumio[880]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 11 12:30:16 volumio volumio[880]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 11 12:30:16 volumio volumio[880]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 11 12:30:16 volumio volumio[880]: info: Reading ALSA contributions from plugins. Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:16 volumio sudo[7175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 11 12:30:16 volumio sudo[7175]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio volumio[880]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Dec 11 12:30:16 volumio volumio[880]: info: MPD Permissions set Dec 11 12:30:16 volumio volumio[880]: info: TidalConnect service started! Dec 11 12:30:16 volumio volumio[880]: info: Shairport-Sync Started Dec 11 12:30:16 volumio volumio[880]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 11 12:30:16 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:16 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:16 volumio sudo[7175]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio volumio[880]: info: Executing endpoint qc_getconfig Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 11 12:30:16 volumio qobuz-connect[7145]: 20251211 12:30:16.262 [7145.7145] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 11 12:30:16 volumio qobuz-connect[7145]: 20251211 12:30:16.267 [7145.7145] INFO VolumeManager: [0x10389e8]: Setting new playback volume: 75 Dec 11 12:30:16 volumio qobuz-connect[7145]: 20251211 12:30:16.267 [7145.7145] INFO VolumeManager: [0x10389e8]: Setting new mute state: 0 Dec 11 12:30:16 volumio qobuz-connect[7145]: 20251211 12:30:16.267 [7145.7145] INFO QobuzConnect: [0x10393b8]: Client initialized! Dec 11 12:30:16 volumio qobuz-connect[7145]: 20251211 12:30:16.267 [7145.7145] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio sudo[7177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 11 12:30:16 volumio sudo[7177]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio qobuz-connect[7145]: 20251211 12:30:16.287 [7145.7145] INFO LocalConfigManager: [0x10382c8]: Starting Local Configuration server Dec 11 12:30:16 volumio qobuz-connect[7145]: 20251211 12:30:16.287 [7145.7145] INFO SampleApp: Starting Local configuration server Dec 11 12:30:16 volumio qobuz-connect[7145]: 20251211 12:30:16.287 [7145.7145] INFO SampleApp: Connected to UNIX socket client 0x102df60 Dec 11 12:30:16 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 11 12:30:16 volumio qobuz-connect[7145]: 20251211 12:30:16.298 [7145.7145] INFO SampleApp: Stopping Local configuration server Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio qobuz-connect[7145]: 20251211 12:30:16.309 [7145.7145] INFO SampleApp: shat down connection on UNIX socket Dec 11 12:30:16 volumio systemd[1]: qobuz-connect.service: Succeeded. Dec 11 12:30:16 volumio volumio[880]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 11 12:30:16 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 11 12:30:16 volumio volumio[880]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:16 volumio volumio[880]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 11 12:30:16 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:16 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:16 volumio volumio[880]: info: Starting Shairport Sync Dec 11 12:30:16 volumio systemd[1]: Started Volumio Qobuz Connect Service. Dec 11 12:30:16 volumio sudo[7177]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio volumio[880]: info: Asound.conf file unchanged, so no further update is needed Dec 11 12:30:16 volumio volumio[880]: info: Output device has changed, restarting MPD Dec 11 12:30:16 volumio sudo[7196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 12:30:16 volumio sudo[7196]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio volumiossh-tunnel[7013]: Warning: remote port forwarding failed for listen port 8091 Dec 11 12:30:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 11 12:30:16 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 11 12:30:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 11 12:30:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 11 12:30:16 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 11 12:30:16 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 2. Dec 11 12:30:16 volumio sudo[7196]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 11 12:30:16 volumio systemd[1]: Started FusionDsp Daemon. Dec 11 12:30:16 volumio sudo[7212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 11 12:30:16 volumio sudo[7212]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio volumio[880]: info: Output device has changed, restarting Shairport Sync Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:16 volumio sudo[7212]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio sudo[7220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 11 12:30:16 volumio sudo[7220]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio volumio[7214]: Traceback (most recent call last): Dec 11 12:30:16 volumio volumio[7214]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 11 12:30:16 volumio volumio[7214]: from aiohttp import web Dec 11 12:30:16 volumio volumio[7214]: ModuleNotFoundError: No module named 'aiohttp' Dec 11 12:30:16 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 11 12:30:16 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 11 12:30:16 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 11 12:30:16 volumio systemd[1]: mpd.service: Succeeded. Dec 11 12:30:16 volumio systemd[1]: Stopped Music Player Daemon. Dec 11 12:30:16 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:16 volumio volumio[880]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 12:30:16 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:16 volumio volumio[880]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio systemd[1]: Starting Music Player Daemon... Dec 11 12:30:16 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:16 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:16 volumio sudo[7244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:16 volumio sudo[7244]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio sudo[7240]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 11 12:30:16 volumio sudo[7240]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio sudo[7247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:16 volumio sudo[7247]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio sudo[7240]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio sudo[7244]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio sudo[7247]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:16 volumio sudo[7256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 11 12:30:16 volumio sudo[7256]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:16 volumio volumio[880]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Dec 11 12:30:16 volumio volumio[880]: info: MPD Permissions set Dec 11 12:30:16 volumio volumio[880]: info: TidalConnect service started! Dec 11 12:30:16 volumio volumio[880]: info: Shairport-Sync Started Dec 11 12:30:16 volumio sudo[7256]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio volumio[880]: info: Executing endpoint qc_getconfig Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 11 12:30:16 volumio qobuz-connect[7184]: 20251211 12:30:16.699 [7184.7184] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio qobuz-connect[7184]: 20251211 12:30:16.703 [7184.7184] INFO VolumeManager: [0x5ae9e8]: Setting new playback volume: 75 Dec 11 12:30:16 volumio qobuz-connect[7184]: 20251211 12:30:16.703 [7184.7184] INFO VolumeManager: [0x5ae9e8]: Setting new mute state: 0 Dec 11 12:30:16 volumio qobuz-connect[7184]: 20251211 12:30:16.704 [7184.7184] INFO QobuzConnect: [0x5af3b8]: Client initialized! Dec 11 12:30:16 volumio qobuz-connect[7184]: 20251211 12:30:16.704 [7184.7184] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio sudo[7259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 11 12:30:16 volumio sudo[7259]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio qobuz-connect[7184]: 20251211 12:30:16.713 [7184.7184] INFO LocalConfigManager: [0x5ae2c8]: Starting Local Configuration server Dec 11 12:30:16 volumio qobuz-connect[7184]: 20251211 12:30:16.713 [7184.7184] INFO SampleApp: Starting Local configuration server Dec 11 12:30:16 volumio qobuz-connect[7184]: 20251211 12:30:16.714 [7184.7184] INFO SampleApp: Connected to UNIX socket client 0x5a3f60 Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:16 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 11 12:30:16 volumio volumio[880]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 11 12:30:16 volumio volumio[880]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 11 12:30:16 volumio qobuz-connect[7184]: 20251211 12:30:16.746 [7184.7184] INFO SampleApp: Stopping Local configuration server Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:16 volumio volumio[880]: info: Starting Shairport Sync Dec 11 12:30:16 volumio qobuz-connect[7184]: 20251211 12:30:16.756 [7184.7184] INFO SampleApp: shat down connection on UNIX socket Dec 11 12:30:16 volumio systemd[1]: qobuz-connect.service: Succeeded. Dec 11 12:30:16 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:16 volumio volumio[880]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 11 12:30:16 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:16 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:16 volumio sudo[7268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 12:30:16 volumio sudo[7268]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:16 volumio systemd[1]: Started Volumio Qobuz Connect Service. Dec 11 12:30:16 volumio sudo[7259]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 11 12:30:16 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 11 12:30:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:16 volumio volumio[880]: info: Executing endpoint qc_getconfig Dec 11 12:30:16 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 11 12:30:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 11 12:30:16 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:16 volumio qobuz-connect[7267]: 20251211 12:30:16.849 [7267.7267] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 11 12:30:16 volumio volumio[880]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 11 12:30:16 volumio volumio[880]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 11 12:30:16 volumio qobuz-connect[7267]: 20251211 12:30:16.854 [7267.7267] INFO VolumeManager: [0x15979e8]: Setting new playback volume: 75 Dec 11 12:30:16 volumio qobuz-connect[7267]: 20251211 12:30:16.854 [7267.7267] INFO VolumeManager: [0x15979e8]: Setting new mute state: 0 Dec 11 12:30:16 volumio qobuz-connect[7267]: 20251211 12:30:16.854 [7267.7267] INFO QobuzConnect: [0x15983b8]: Client initialized! Dec 11 12:30:16 volumio qobuz-connect[7267]: 20251211 12:30:16.854 [7267.7267] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 11 12:30:16 volumio sudo[7268]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:16 volumio volumio[880]: info: Shairport-Sync Started Dec 11 12:30:16 volumio qobuz-connect[7267]: 20251211 12:30:16.874 [7267.7267] INFO LocalConfigManager: [0x15972c8]: Starting Local Configuration server Dec 11 12:30:16 volumio qobuz-connect[7267]: 20251211 12:30:16.874 [7267.7267] INFO SampleApp: Starting Local configuration server Dec 11 12:30:16 volumio qobuz-connect[7267]: 20251211 12:30:16.874 [7267.7267] INFO SampleApp: Connected to UNIX socket client 0x158cf60 Dec 11 12:30:17 volumio qobuz-connect[7267]: 20251211 12:30:16.999 [7267.7267] INFO SampleApp: Playback volume changed: 75 Dec 11 12:30:17 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:17 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:17 volumio mpd[7253]: Dec 11 12:30 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 11 12:30:17 volumio systemd[1]: Started Music Player Daemon. Dec 11 12:30:17 volumio sudo[7220]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:17 volumio sudo[7148]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:17 volumio sudo[7111]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:17 volumio volumio[880]: error: MPD error: The expression evaluated to a falsy value: Dec 11 12:30:17 volumio volumio[880]: assert.ok(self.idling) Dec 11 12:30:17 volumio volumio[880]: error: The expression evaluated to a falsy value: Dec 11 12:30:17 volumio volumio[880]: assert.ok(self.idling) Dec 11 12:30:17 volumio volumio[880]: error: MPD error: The expression evaluated to a falsy value: Dec 11 12:30:17 volumio volumio[880]: assert.ok(self.idling) Dec 11 12:30:17 volumio volumio[880]: error: The expression evaluated to a falsy value: Dec 11 12:30:17 volumio volumio[880]: assert.ok(self.idling) Dec 11 12:30:17 volumio volumio[880]: error: updateQueue error: null Dec 11 12:30:17 volumio volumio[880]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Dec 11 12:30:17 volumio volumio[880]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Dec 11 12:30:17 volumio volumio[880]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Dec 11 12:30:17 volumio volumio[880]: info: camilladsp service started and running in background, instance 2 Dec 11 12:30:17 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:17 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:17 volumio volumio[880]: cannot open device 'volumioHw': Device or resource busy Dec 11 12:30:17 volumio volumio[880]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Dec 11 12:30:17 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:17 volumio volumio[880]: cannot open device 'volumioHw': Device or resource busy Dec 11 12:30:17 volumio volumio[880]: info: FusionDsp loaded Dec 11 12:30:17 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 11 12:30:17 volumio volumio[880]: info: FusionDsp - Reporting Fusion DSP Enabled Dec 11 12:30:17 volumio volumio[880]: info: Adding Signal Path Element [object Object] Dec 11 12:30:17 volumio volumio[880]: info: Updating fusiondspeq DSP Signal Path Element Dec 11 12:30:17 volumio volumio[880]: info: FusionDsp - ---- installed callbackRead Dec 11 12:30:17 volumio volumio[880]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 11 12:30:17 volumio volumio[880]: info: FusionDsp - ---- read samplerate, raw: Dec 11 12:30:17 volumio volumio[880]: error: FusionDsp - invalid sample rate Dec 11 12:30:17 volumio volumio[880]: info: FusionDsp - ---- read samplerate, raw: Dec 11 12:30:17 volumio volumio[880]: error: FusionDsp - invalid sample rate Dec 11 12:30:17 volumio sudo[7293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Dec 11 12:30:17 volumio sudo[7293]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:17 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:17 volumio volumio[880]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Dec 11 12:30:17 volumio volumio[880]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 11 12:30:17 volumio volumio[880]: info: Enabling plugin fusiondsp Dec 11 12:30:17 volumio volumio[880]: info: Loading plugin "fusiondsp"... Dec 11 12:30:17 volumio volumio[880]: info: Applying required configuration parameters for plugin fusiondsp Dec 11 12:30:17 volumio volumio[880]: info: Preparing to generate the ALSA configuration file Dec 11 12:30:17 volumio volumio[880]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 11 12:30:17 volumio volumio[880]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 11 12:30:17 volumio volumio[880]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 11 12:30:17 volumio volumio[880]: info: Reading ALSA contributions from plugins. Dec 11 12:30:17 volumio volumio[880]: info: Asound.conf file unchanged, so no further update is needed Dec 11 12:30:17 volumio volumio[880]: info: Output device has changed, restarting MPD Dec 11 12:30:18 volumio sudo[7311]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 11 12:30:18 volumio sudo[7311]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio sudo[7311]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio volumio[880]: info: Output device has changed, restarting Shairport Sync Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:18 volumio sudo[7314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 11 12:30:18 volumio sudo[7314]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio systemd[1]: Stopping Music Player Daemon... Dec 11 12:30:18 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:18 volumio volumio[880]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 12:30:18 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:18 volumio volumio[880]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:18 volumio systemd[1]: mpd.service: Succeeded. Dec 11 12:30:18 volumio systemd[1]: Stopped Music Player Daemon. Dec 11 12:30:18 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:18 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:18 volumio volumio[880]: info: PLUGIN START: fusiondsp Dec 11 12:30:18 volumio volumio[880]: info: Loading i18n strings for locale it Dec 11 12:30:18 volumio volumio[880]: info: Plugin peppymeterbasic has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Dec 11 12:30:18 volumio volumio[880]: info: Plugin peppymeterbasic has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:18 volumio volumio[880]: info: FusionDsp - mixtype--------------------- Hardware Dec 11 12:30:18 volumio volumio[880]: info: Preparing to generate the ALSA configuration file Dec 11 12:30:18 volumio sudo[7323]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:18 volumio sudo[7323]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio volumio[880]: info: Done. Dec 11 12:30:18 volumio systemd[1]: Starting Music Player Daemon... Dec 11 12:30:18 volumio sudo[7326]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:18 volumio sudo[7326]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio sudo[7323]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio sudo[7326]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio sudo[7334]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 11 12:30:18 volumio sudo[7334]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio volumio[880]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 11 12:30:18 volumio volumio[880]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 11 12:30:18 volumio volumio[880]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 11 12:30:18 volumio volumio[880]: info: Reading ALSA contributions from plugins. Dec 11 12:30:18 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:18 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:18 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:18 volumio sudo[7320]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 11 12:30:18 volumio sudo[7320]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio volumio[880]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Dec 11 12:30:18 volumio volumio[880]: info: MPD Permissions set Dec 11 12:30:18 volumio sudo[7320]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio sudo[7334]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio volumio[880]: info: Enabling plugin fusiondsp Dec 11 12:30:18 volumio volumio[880]: info: Loading plugin "fusiondsp"... Dec 11 12:30:18 volumio volumio[880]: info: Applying required configuration parameters for plugin fusiondsp Dec 11 12:30:18 volumio sudo[7339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 11 12:30:18 volumio sudo[7339]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:18 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 11 12:30:18 volumio qobuz-connect[7267]: 20251211 12:30:18.274 [7267.7267] INFO SampleApp: Stopping Local configuration server Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:18 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:18 volumio qobuz-connect[7267]: 20251211 12:30:18.286 [7267.7267] INFO SampleApp: shat down connection on UNIX socket Dec 11 12:30:18 volumio systemd[1]: qobuz-connect.service: Succeeded. Dec 11 12:30:18 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 11 12:30:18 volumio volumio[880]: info: Starting Shairport Sync Dec 11 12:30:18 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:18 volumio volumio[880]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 11 12:30:18 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:18 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:18 volumio volumio[880]: info: Asound.conf file unchanged, so no further update is needed Dec 11 12:30:18 volumio volumio[880]: info: Output device has changed, restarting MPD Dec 11 12:30:18 volumio sudo[7360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 12:30:18 volumio sudo[7360]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio sudo[7363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 11 12:30:18 volumio systemd[1]: Started Volumio Qobuz Connect Service. Dec 11 12:30:18 volumio sudo[7363]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio volumio[880]: info: Output device has changed, restarting Shairport Sync Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:18 volumio sudo[7363]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:18 volumio sudo[7339]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 11 12:30:18 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 11 12:30:18 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 11 12:30:18 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Dec 11 12:30:18 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Dec 11 12:30:18 volumio systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Dec 11 12:30:18 volumio sudo[7366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 11 12:30:18 volumio sudo[7366]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio sudo[7360]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 11 12:30:18 volumio systemd[1]: mpd.service: Succeeded. Dec 11 12:30:18 volumio systemd[1]: Stopped Music Player Daemon. Dec 11 12:30:18 volumio systemd[1]: Starting Music Player Daemon... Dec 11 12:30:18 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:18 volumio volumio[880]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 12:30:18 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:18 volumio volumio[880]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:18 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:18 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:18 volumio volumio[880]: info: Preparing to generate the ALSA configuration file Dec 11 12:30:18 volumio sudo[7376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:18 volumio sudo[7376]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio sudo[7372]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 11 12:30:18 volumio sudo[7372]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio sudo[7372]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 11 12:30:18 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 3. Dec 11 12:30:18 volumio sudo[7376]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 11 12:30:18 volumio sudo[7380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:18 volumio sudo[7380]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio systemd[1]: Started FusionDsp Daemon. Dec 11 12:30:18 volumio sudo[7293]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio volumio[880]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 11 12:30:18 volumio volumio[880]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 11 12:30:18 volumio volumio[880]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 11 12:30:18 volumio volumio[880]: info: Reading ALSA contributions from plugins. Dec 11 12:30:18 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:18 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:18 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:18 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:18 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:18 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:18 volumio sudo[7389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 11 12:30:18 volumio sudo[7389]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:18 volumio volumio[880]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Dec 11 12:30:18 volumio volumio[880]: info: MPD Permissions set Dec 11 12:30:18 volumio volumio[880]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Dec 11 12:30:18 volumio volumio[880]: Job for shairport-sync.service failed. Dec 11 12:30:18 volumio volumio[880]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Dec 11 12:30:18 volumio sudo[7380]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio volumio[880]: info: Executing endpoint qc_getconfig Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 11 12:30:18 volumio qobuz-connect[7352]: 20251211 12:30:18.620 [7352.7352] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 11 12:30:18 volumio qobuz-connect[7352]: 20251211 12:30:18.626 [7352.7352] INFO VolumeManager: [0x9a39e8]: Setting new playback volume: 75 Dec 11 12:30:18 volumio qobuz-connect[7352]: 20251211 12:30:18.628 [7352.7352] INFO VolumeManager: [0x9a39e8]: Setting new mute state: 0 Dec 11 12:30:18 volumio qobuz-connect[7352]: 20251211 12:30:18.628 [7352.7352] INFO QobuzConnect: [0x9a43b8]: Client initialized! Dec 11 12:30:18 volumio qobuz-connect[7352]: 20251211 12:30:18.628 [7352.7352] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 11 12:30:18 volumio qobuz-connect[7352]: 20251211 12:30:18.640 [7352.7352] INFO LocalConfigManager: [0x9a32c8]: Starting Local Configuration server Dec 11 12:30:18 volumio qobuz-connect[7352]: 20251211 12:30:18.640 [7352.7352] INFO SampleApp: Starting Local configuration server Dec 11 12:30:18 volumio qobuz-connect[7352]: 20251211 12:30:18.641 [7352.7352] INFO SampleApp: Connected to UNIX socket client 0x998f60 Dec 11 12:30:18 volumio volumio[880]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 11 12:30:18 volumio volumio[880]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:18 volumio sudo[7389]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio volumio[7386]: Traceback (most recent call last): Dec 11 12:30:18 volumio volumio[7386]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 11 12:30:18 volumio volumio[7386]: from aiohttp import web Dec 11 12:30:18 volumio volumio[7386]: ModuleNotFoundError: No module named 'aiohttp' Dec 11 12:30:18 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 11 12:30:18 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:18 volumio sudo[7402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 11 12:30:18 volumio sudo[7402]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 11 12:30:18 volumio qobuz-connect[7352]: 20251211 12:30:18.713 [7352.7352] INFO SampleApp: Stopping Local configuration server Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:18 volumio qobuz-connect[7352]: 20251211 12:30:18.723 [7352.7352] INFO SampleApp: shat down connection on UNIX socket Dec 11 12:30:18 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:18 volumio systemd[1]: qobuz-connect.service: Succeeded. Dec 11 12:30:18 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 11 12:30:18 volumio volumio[880]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 11 12:30:18 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:18 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:18 volumio volumio[880]: info: Starting Shairport Sync Dec 11 12:30:18 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:18 volumio volumio[880]: info: Asound.conf file unchanged, so no further update is needed Dec 11 12:30:18 volumio volumio[880]: info: Output device has changed, restarting MPD Dec 11 12:30:18 volumio systemd[1]: Started Volumio Qobuz Connect Service. Dec 11 12:30:18 volumio sudo[7429]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 12:30:18 volumio sudo[7429]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio sudo[7402]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Dec 11 12:30:18 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Dec 11 12:30:18 volumio systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Dec 11 12:30:18 volumio sudo[7429]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio sudo[7433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 11 12:30:18 volumio sudo[7433]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio volumio[880]: info: Output device has changed, restarting Shairport Sync Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:18 volumio sudo[7433]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio sudo[7436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 11 12:30:18 volumio sudo[7436]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 11 12:30:18 volumio systemd[1]: mpd.service: Succeeded. Dec 11 12:30:18 volumio systemd[1]: Stopped Music Player Daemon. Dec 11 12:30:18 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:18 volumio volumio[880]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 12:30:18 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:18 volumio volumio[880]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:18 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:18 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:18 volumio volumio[880]: info: PLUGIN START: fusiondsp Dec 11 12:30:18 volumio volumio[880]: info: Loading i18n strings for locale it Dec 11 12:30:18 volumio volumio[880]: info: Plugin peppymeterbasic has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Dec 11 12:30:18 volumio volumio[880]: info: Plugin peppymeterbasic has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 11 12:30:18 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:18 volumio volumio[880]: info: FusionDsp - mixtype--------------------- Hardware Dec 11 12:30:18 volumio volumio[880]: info: Preparing to generate the ALSA configuration file Dec 11 12:30:18 volumio sudo[7445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:18 volumio sudo[7445]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:18 volumio systemd[1]: Starting Music Player Daemon... Dec 11 12:30:18 volumio volumio[880]: info: Done. Dec 11 12:30:18 volumio sudo[7445]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:18 volumio sudo[7449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:18 volumio sudo[7449]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio sudo[7449]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:19 volumio sudo[7441]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 11 12:30:19 volumio sudo[7441]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio volumio[880]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Dec 11 12:30:19 volumio sudo[7441]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:19 volumio volumio[880]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 11 12:30:19 volumio volumio[880]: info: The plugin peppymeterbasic has an ALSA contribution file peppy_in.peppy_out.6.conf Dec 11 12:30:19 volumio volumio[880]: info: Reading ALSA contributions from plugins. Dec 11 12:30:19 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:19 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:19 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:19 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:19 volumio sudo[7455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 11 12:30:19 volumio sudo[7455]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio volumio[880]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Dec 11 12:30:19 volumio volumio[880]: info: MPD Permissions set Dec 11 12:30:19 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:19 volumio sudo[7455]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:19 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:19 volumio volumio[880]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Dec 11 12:30:19 volumio volumio[880]: Job for shairport-sync.service failed. Dec 11 12:30:19 volumio volumio[880]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Dec 11 12:30:19 volumio sudo[7461]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 11 12:30:19 volumio sudo[7461]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio volumio[880]: info: Executing endpoint qc_getconfig Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 11 12:30:19 volumio qobuz-connect[7420]: 20251211 12:30:19.087 [7420.7420] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 11 12:30:19 volumio qobuz-connect[7420]: 20251211 12:30:19.099 [7420.7420] INFO VolumeManager: [0x17b59e8]: Setting new playback volume: 75 Dec 11 12:30:19 volumio qobuz-connect[7420]: 20251211 12:30:19.099 [7420.7420] INFO VolumeManager: [0x17b59e8]: Setting new mute state: 0 Dec 11 12:30:19 volumio qobuz-connect[7420]: 20251211 12:30:19.099 [7420.7420] INFO QobuzConnect: [0x17b63b8]: Client initialized! Dec 11 12:30:19 volumio qobuz-connect[7420]: 20251211 12:30:19.099 [7420.7420] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 11 12:30:19 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 11 12:30:19 volumio qobuz-connect[7420]: 20251211 12:30:19.114 [7420.7420] INFO LocalConfigManager: [0x17b52c8]: Starting Local Configuration server Dec 11 12:30:19 volumio qobuz-connect[7420]: 20251211 12:30:19.115 [7420.7420] INFO SampleApp: Starting Local configuration server Dec 11 12:30:19 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:19 volumio qobuz-connect[7420]: 20251211 12:30:19.118 [7420.7420] INFO SampleApp: Stopping Local configuration server Dec 11 12:30:19 volumio volumio[880]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 11 12:30:19 volumio volumio[880]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 11 12:30:19 volumio qobuz-connect[7420]: 20251211 12:30:19.128 [7420.7420] INFO SampleApp: shat down connection on UNIX socket Dec 11 12:30:19 volumio qobuz-connect[7420]: qobuz-connect-daemon: /home/volumio/qobuz-connect-daemon/sample_console_app/volumio/pipe.c:199: pipe_connect_callback: Assertion `status == 0' failed. Dec 11 12:30:19 volumio systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=6/ABRT Dec 11 12:30:19 volumio systemd[1]: qobuz-connect.service: Failed with result 'signal'. Dec 11 12:30:19 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:19 volumio volumio[880]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 11 12:30:19 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:19 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:19 volumio volumio[880]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:19 volumio volumio[880]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:19 volumio systemd[1]: Started Volumio Qobuz Connect Service. Dec 11 12:30:19 volumio sudo[7461]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:19 volumio volumio[880]: info: Starting Shairport Sync Dec 11 12:30:19 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:19 volumio volumio[880]: info: Executing endpoint qc_getconfig Dec 11 12:30:19 volumio sudo[7492]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 12:30:19 volumio sudo[7492]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 11 12:30:19 volumio qobuz-connect[7475]: 20251211 12:30:19.249 [7475.7475] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 11 12:30:19 volumio qobuz-connect[7475]: 20251211 12:30:19.254 [7475.7475] INFO VolumeManager: [0x23389e8]: Setting new playback volume: 75 Dec 11 12:30:19 volumio qobuz-connect[7475]: 20251211 12:30:19.254 [7475.7475] INFO VolumeManager: [0x23389e8]: Setting new mute state: 0 Dec 11 12:30:19 volumio qobuz-connect[7475]: 20251211 12:30:19.254 [7475.7475] INFO QobuzConnect: [0x23393b8]: Client initialized! Dec 11 12:30:19 volumio qobuz-connect[7475]: 20251211 12:30:19.254 [7475.7475] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 11 12:30:19 volumio qobuz-connect[7475]: 20251211 12:30:19.263 [7475.7475] INFO LocalConfigManager: [0x23382c8]: Starting Local Configuration server Dec 11 12:30:19 volumio qobuz-connect[7475]: 20251211 12:30:19.263 [7475.7475] INFO SampleApp: Starting Local configuration server Dec 11 12:30:19 volumio qobuz-connect[7475]: 20251211 12:30:19.264 [7475.7475] INFO SampleApp: Connected to UNIX socket client 0x232df60 Dec 11 12:30:19 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Dec 11 12:30:19 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Dec 11 12:30:19 volumio systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Dec 11 12:30:19 volumio sudo[7492]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:19 volumio volumio[880]: info: Asound.conf file unchanged, so no further update is needed Dec 11 12:30:19 volumio volumio[880]: info: Output device has changed, restarting MPD Dec 11 12:30:19 volumio sudo[7496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 11 12:30:19 volumio sudo[7496]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio sudo[7499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 11 12:30:19 volumio sudo[7499]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio volumio[880]: info: Output device has changed, restarting Shairport Sync Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:19 volumio sudo[7499]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:19 volumio sudo[7502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 11 12:30:19 volumio qobuz-connect[7475]: 20251211 12:30:19.399 [7475.7475] INFO SampleApp: Playback volume changed: 75 Dec 11 12:30:19 volumio systemd[1]: Started Volumio Tidal Connect Service. Dec 11 12:30:19 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:19 volumio volumio[880]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 11 12:30:19 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:19 volumio volumio[880]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:19 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:19 volumio sudo[7502]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio sudo[7511]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:19 volumio sudo[7496]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:19 volumio sudo[7511]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 11 12:30:19 volumio systemd[1]: mpd.service: Succeeded. Dec 11 12:30:19 volumio systemd[1]: Stopped Music Player Daemon. Dec 11 12:30:19 volumio sudo[7514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Dec 11 12:30:19 volumio systemd[1]: Starting Music Player Daemon... Dec 11 12:30:19 volumio sudo[7514]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Dec 11 12:30:19 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Dec 11 12:30:19 volumio systemd[1]: vtcs.service: Succeeded. Dec 11 12:30:19 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Dec 11 12:30:19 volumio volumio[880]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 11 12:30:19 volumio volumio[880]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 11 12:30:19 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:19 volumio sudo[7514]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:19 volumio sudo[7511]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:19 volumio sudo[7523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Dec 11 12:30:19 volumio sudo[7523]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:19 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:19 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:19 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:19 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:19 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:19 volumio sudo[7523]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:19 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:19 volumio volumio[880]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Dec 11 12:30:19 volumio volumio[880]: info: MPD Permissions set Dec 11 12:30:19 volumio volumio[880]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Dec 11 12:30:19 volumio volumio[880]: Job for shairport-sync.service failed. Dec 11 12:30:19 volumio volumio[880]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Dec 11 12:30:19 volumio sudo[7519]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 11 12:30:19 volumio sudo[7519]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio sudo[7531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Dec 11 12:30:19 volumio sudo[7531]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio sudo[7519]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:19 volumio volumio[880]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:19 volumio volumio[880]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:19 volumio volumio[880]: info: Starting Shairport Sync Dec 11 12:30:19 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Dec 11 12:30:19 volumio qobuz-connect[7475]: 20251211 12:30:19.662 [7475.7475] INFO SampleApp: Stopping Local configuration server Dec 11 12:30:19 volumio qobuz-connect[7475]: 20251211 12:30:19.672 [7475.7475] INFO SampleApp: shat down connection on UNIX socket Dec 11 12:30:19 volumio sudo[7559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 11 12:30:19 volumio systemd[1]: qobuz-connect.service: Succeeded. Dec 11 12:30:19 volumio sudo[7559]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Dec 11 12:30:19 volumio systemd[1]: Started Volumio Qobuz Connect Service. Dec 11 12:30:19 volumio sudo[7531]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:19 volumio sudo[7563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 11 12:30:19 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: running Dec 11 12:30:19 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:19 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:19 volumio sudo[7563]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Dec 11 12:30:19 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Dec 11 12:30:19 volumio systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Dec 11 12:30:19 volumio sudo[7559]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:19 volumio volumio[880]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Dec 11 12:30:19 volumio volumio[880]: info: QobuzConnect: setDeactiveState invoked Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:19 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:19 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:19 volumio systemd[1]: Started Volumio Tidal Connect Service. Dec 11 12:30:19 volumio sudo[7563]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:19 volumio volumio[880]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Dec 11 12:30:19 volumio volumio[880]: Job for shairport-sync.service failed. Dec 11 12:30:19 volumio volumio[880]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Dec 11 12:30:19 volumio volumio[880]: info: Executing endpoint qc_getconfig Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Dec 11 12:30:19 volumio qobuz-connect[7562]: 20251211 12:30:19.817 [7562.7562] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Dec 11 12:30:19 volumio volumio[880]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:19 volumio volumio[880]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:19 volumio qobuz-connect[7562]: 20251211 12:30:19.821 [7562.7562] INFO VolumeManager: [0x142c9e8]: Setting new playback volume: 75 Dec 11 12:30:19 volumio qobuz-connect[7562]: 20251211 12:30:19.822 [7562.7562] INFO VolumeManager: [0x142c9e8]: Setting new mute state: 0 Dec 11 12:30:19 volumio qobuz-connect[7562]: 20251211 12:30:19.822 [7562.7562] INFO QobuzConnect: [0x142d3b8]: Client initialized! Dec 11 12:30:19 volumio qobuz-connect[7562]: 20251211 12:30:19.822 [7562.7562] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Dec 11 12:30:19 volumio volumio[880]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Dec 11 12:30:19 volumio volumio[880]: info: QobuzConnect: QOBUZ Connect daemon connected Dec 11 12:30:19 volumio qobuz-connect[7562]: 20251211 12:30:19.842 [7562.7562] INFO LocalConfigManager: [0x142c2c8]: Starting Local Configuration server Dec 11 12:30:19 volumio qobuz-connect[7562]: 20251211 12:30:19.842 [7562.7562] INFO SampleApp: Starting Local configuration server Dec 11 12:30:19 volumio qobuz-connect[7562]: 20251211 12:30:19.842 [7562.7562] INFO SampleApp: Connected to UNIX socket client 0x1421f60 Dec 11 12:30:19 volumio sudo[7586]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 11 12:30:19 volumio sudo[7586]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:19 volumio sudo[7586]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:19 volumio qobuz-connect[7562]: 20251211 12:30:19.968 [7562.7562] INFO SampleApp: Playback volume changed: 75 Dec 11 12:30:19 volumio volumio[880]: info: Executing endpoint tc_getconfig Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Dec 11 12:30:19 volumio vtcs[7570]: STARTING TidalConnect services, version: 1.5.1-beta1 Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:19 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:19 volumio vtcs[7570]: STARTED TidalConnect services. Dec 11 12:30:19 volumio volumio[880]: info: Executing endpoint tc_connect Dec 11 12:30:19 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Dec 11 12:30:19 volumio volumio[880]: info: Connecting to TidalConnect Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::servicePushState Dec 11 12:30:20 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:30:20 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:30:20 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:30:20 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:20 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:20 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:20 volumio volumio[880]: 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} Dec 11 12:30:20 volumio volumio[880]: verbose: CURRENT POSITION 0 Dec 11 12:30:20 volumio volumio[880]: info: CoreStateMachine::syncState stateService stop Dec 11 12:30:20 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus stop Dec 11 12:30:20 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:30:20 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:30:20 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:30:20 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:20 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:20 volumio volumio[880]: info: No code Dec 11 12:30:20 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:30:20 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:30:20 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:30:20 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:20 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::servicePushState Dec 11 12:30:20 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:30:20 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:30:20 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:30:20 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:20 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:20 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:20 volumio volumio[880]: 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} Dec 11 12:30:20 volumio volumio[880]: verbose: CURRENT POSITION 0 Dec 11 12:30:20 volumio volumio[880]: info: CoreStateMachine::syncState stateService stop Dec 11 12:30:20 volumio volumio[880]: info: CoreStateMachine::syncState currentStatus stop Dec 11 12:30:20 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:30:20 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:30:20 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:30:20 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:20 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:20 volumio volumio[880]: info: No code Dec 11 12:30:20 volumio volumio[880]: info: CoreStateMachine::pushState Dec 11 12:30:20 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::volumioPushState Dec 11 12:30:20 volumio volumio[880]: info: MRS: Pushing multiroomSync output update for this device Dec 11 12:30:20 volumio volumio[880]: info: MRS: Pushing multiroomSync output Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::volumioGetState Dec 11 12:30:20 volumio volumio[880]: info: CorePlayQueue::getTrack 0 Dec 11 12:30:20 volumio volumio[880]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 11 12:30:20 volumio volumio[880]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 11 12:30:20 volumio volumio[880]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 11 12:30:20 volumio volumio[880]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 11 12:30:20 volumio volumio[880]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 11 12:30:20 volumio volumio[880]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Dec 11 12:30:20 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:30:20 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:30:20 volumio sudo[7627]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:30:20 volumio sudo[7627]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:20 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:30:20 volumio sudo[7630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:30:20 volumio sudo[7630]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:20 volumio sudo[7627]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:20 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:30:20 volumio sudo[7630]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:20 volumio sudo[7635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:30:20 volumio sudo[7635]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:20 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:30:20 volumio sudo[7638]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:30:20 volumio sudo[7638]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:20 volumio sudo[7635]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:20 volumio volumio[880]: info: PeppyMeterBasic ---peppymeterbasic status stop Dec 11 12:30:20 volumio sudo[7641]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:30:20 volumio sudo[7641]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:20 volumio sudo[7638]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:20 volumio sudo[7644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Dec 11 12:30:20 volumio sudo[7644]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:20 volumio sudo[7641]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:20 volumio sudo[7644]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:20 volumio volumio[880]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Dec 11 12:30:20 volumio volumio[880]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Dec 11 12:30:20 volumio volumio[880]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Dec 11 12:30:20 volumio volumio[880]: info: camilladsp service started and running in background, instance 3 Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:20 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:20 volumio volumio[880]: cannot open device 'volumioHw': Device or resource busy Dec 11 12:30:20 volumio volumio[880]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Dec 11 12:30:20 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:20 volumio volumio[880]: cannot open device 'volumioHw': Device or resource busy Dec 11 12:30:20 volumio volumio[880]: info: FusionDsp loaded Dec 11 12:30:20 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 11 12:30:20 volumio volumio[880]: info: FusionDsp - Reporting Fusion DSP Enabled Dec 11 12:30:20 volumio volumio[880]: info: Adding Signal Path Element [object Object] Dec 11 12:30:20 volumio volumio[880]: info: Updating fusiondspeq DSP Signal Path Element Dec 11 12:30:20 volumio volumio[880]: info: FusionDsp - ---- installed callbackRead Dec 11 12:30:20 volumio volumio[880]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 11 12:30:20 volumio volumio[880]: info: FusionDsp - ---- read samplerate, raw: Dec 11 12:30:20 volumio sudo[7662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Dec 11 12:30:20 volumio volumio[880]: error: FusionDsp - invalid sample rate Dec 11 12:30:20 volumio volumio[880]: info: FusionDsp - ---- read samplerate, raw: Dec 11 12:30:20 volumio volumio[880]: error: FusionDsp - invalid sample rate Dec 11 12:30:20 volumio sudo[7662]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:20 volumio volumio[880]: info: FusionDsp - ---- read samplerate, raw: Dec 11 12:30:20 volumio volumio[880]: error: FusionDsp - invalid sample rate Dec 11 12:30:20 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:30:20 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:30:20 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:30:20 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:30:20 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:30:20 volumio volumio[880]: info: peppymeterbasic Daemon Stop Dec 11 12:30:20 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:20 volumio volumio[880]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Dec 11 12:30:20 volumio volumio[880]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 11 12:30:20 volumio mpd[7535]: Dec 11 12:30 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Dec 11 12:30:20 volumio systemd[1]: Started Music Player Daemon. Dec 11 12:30:20 volumio sudo[7502]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:20 volumio sudo[7366]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:20 volumio sudo[7314]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:20 volumio sudo[7436]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:20 volumio volumio[880]: error: MPD error: The expression evaluated to a falsy value: Dec 11 12:30:20 volumio volumio[880]: assert.ok(self.idling) Dec 11 12:30:20 volumio volumio[880]: error: The expression evaluated to a falsy value: Dec 11 12:30:20 volumio volumio[880]: assert.ok(self.idling) Dec 11 12:30:20 volumio volumio[880]: error: MPD error: The expression evaluated to a falsy value: Dec 11 12:30:20 volumio volumio[880]: assert.ok(self.idling) Dec 11 12:30:20 volumio volumio[880]: error: The expression evaluated to a falsy value: Dec 11 12:30:20 volumio volumio[880]: assert.ok(self.idling) Dec 11 12:30:20 volumio volumio[880]: error: MPD error: The expression evaluated to a falsy value: Dec 11 12:30:20 volumio volumio[880]: assert.ok(self.idling) Dec 11 12:30:20 volumio volumio[880]: error: The expression evaluated to a falsy value: Dec 11 12:30:20 volumio volumio[880]: assert.ok(self.idling) Dec 11 12:30:20 volumio volumio[880]: error: updateQueue error: null Dec 11 12:30:20 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 11 12:30:20 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 4. Dec 11 12:30:20 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 11 12:30:20 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:20 volumio systemd[1]: Started FusionDsp Daemon. Dec 11 12:30:20 volumio sudo[7662]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:20 volumio volumio[7767]: Traceback (most recent call last): Dec 11 12:30:20 volumio volumio[7767]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 11 12:30:20 volumio volumio[7767]: from aiohttp import web Dec 11 12:30:20 volumio volumio[7767]: ModuleNotFoundError: No module named 'aiohttp' Dec 11 12:30:20 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 11 12:30:20 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 11 12:30:20 volumio volumio[880]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Dec 11 12:30:20 volumio volumio[880]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Dec 11 12:30:20 volumio volumio[880]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Dec 11 12:30:21 volumio volumio[880]: info: camilladsp service started and running in background, instance 4 Dec 11 12:30:21 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 11 12:30:21 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:21 volumio volumio[880]: cannot open device 'volumioHw': Device or resource busy Dec 11 12:30:21 volumio volumio[880]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Dec 11 12:30:21 volumio volumio[880]: xcb_connection_has_error() returned true Dec 11 12:30:21 volumio volumio[880]: cannot open device 'volumioHw': Device or resource busy Dec 11 12:30:21 volumio volumio[880]: info: FusionDsp loaded Dec 11 12:30:21 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 11 12:30:21 volumio volumio[880]: info: FusionDsp - Reporting Fusion DSP Enabled Dec 11 12:30:21 volumio volumio[880]: info: Adding Signal Path Element [object Object] Dec 11 12:30:21 volumio volumio[880]: info: Updating fusiondspeq DSP Signal Path Element Dec 11 12:30:21 volumio volumio[880]: info: FusionDsp - ---- installed callbackRead Dec 11 12:30:21 volumio volumio[880]: info: FusionDsp - If filter freq >samplerate/2 then disable it Dec 11 12:30:21 volumio volumio[880]: info: FusionDsp - ---- read samplerate, raw: Dec 11 12:30:21 volumio volumio[880]: error: FusionDsp - invalid sample rate Dec 11 12:30:21 volumio volumio[880]: info: FusionDsp - ---- read samplerate, raw: Dec 11 12:30:21 volumio volumio[880]: error: FusionDsp - invalid sample rate Dec 11 12:30:21 volumio volumio[880]: info: FusionDsp - ---- read samplerate, raw: Dec 11 12:30:21 volumio volumio[880]: error: FusionDsp - invalid sample rate Dec 11 12:30:21 volumio volumio[880]: info: FusionDsp - ---- read samplerate, raw: Dec 11 12:30:21 volumio volumio[880]: error: FusionDsp - invalid sample rate Dec 11 12:30:21 volumio sudo[7818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Dec 11 12:30:21 volumio sudo[7818]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:21 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:21 volumio volumio[880]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Dec 11 12:30:21 volumio volumio[880]: info: FusionDsp - {"Reload":{"result":"Ok"}} Dec 11 12:30:21 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:21 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:21 volumio volumio[880]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:21 volumio volumio[880]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:21 volumio sudo[7893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 11 12:30:21 volumio sudo[7893]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:21 volumio sudo[7893]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:21 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:21 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:21 volumio volumio[880]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:21 volumio volumio[880]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:21 volumio sudo[8052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 11 12:30:21 volumio sudo[8052]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:21 volumio sudo[8052]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:21 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:22 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:22 volumio volumio[880]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:22 volumio volumio[880]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:22 volumio sudo[8169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 11 12:30:22 volumio sudo[8169]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:22 volumio sudo[8169]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:22 volumio volumio[880]: info: TidalConnect service started! Dec 11 12:30:22 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:22 volumio volumio[880]: info: TidalConnect service stoped! Dec 11 12:30:22 volumio volumio[880]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:22 volumio volumio[880]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Dec 11 12:30:22 volumio sudo[8328]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Dec 11 12:30:22 volumio sudo[8328]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:22 volumio sudo[8328]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:22 volumio volumio[880]: info: TidalConnect service started! Dec 11 12:30:22 volumio volumio[880]: info: TidalConnect service started! Dec 11 12:30:23 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 11 12:30:23 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 5. Dec 11 12:30:23 volumio volumio[880]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Dec 11 12:30:23 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 11 12:30:23 volumio sudo[7818]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:23 volumio systemd[1]: Started FusionDsp Daemon. Dec 11 12:30:23 volumio volumio[8465]: Traceback (most recent call last): Dec 11 12:30:23 volumio volumio[8465]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 11 12:30:23 volumio volumio[8465]: from aiohttp import web Dec 11 12:30:23 volumio volumio[8465]: ModuleNotFoundError: No module named 'aiohttp' Dec 11 12:30:23 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 11 12:30:23 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 11 12:30:24 volumio volumio[880]: info: TidalConnect service started! Dec 11 12:30:24 volumio volumio[880]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Dec 11 12:30:24 volumio volumio[880]: info: TidalConnect service started! Dec 11 12:30:25 volumio volumio[880]: info: TidalConnect service started! Dec 11 12:30:25 volumio systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Dec 11 12:30:25 volumio systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 6. Dec 11 12:30:25 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 11 12:30:25 volumio systemd[1]: Started FusionDsp Daemon. Dec 11 12:30:25 volumio volumio[9218]: Traceback (most recent call last): Dec 11 12:30:25 volumio volumio[9218]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 1, in Dec 11 12:30:25 volumio volumio[9218]: from aiohttp import web Dec 11 12:30:25 volumio volumio[9218]: ModuleNotFoundError: No module named 'aiohttp' Dec 11 12:30:25 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Dec 11 12:30:25 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Dec 11 12:30:25 volumio volumio[880]: info: TidalConnect service started! Dec 11 12:30:27 volumio volumio[880]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Dec 11 12:30:27 volumio volumio[880]: info: FusionDsp - Stopping FusionDsp service Dec 11 12:30:27 volumio volumio[880]: info: camilladsp stopping service pid 9834... Dec 11 12:30:27 volumio volumio[880]: info: camilladsp service terminated, instance 4 Dec 11 12:30:27 volumio sudo[9851]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Dec 11 12:30:27 volumio sudo[9851]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 11 12:30:27 volumio systemd[1]: Stopped FusionDsp Daemon. Dec 11 12:30:27 volumio sudo[9851]: pam_unix(sudo:session): session closed for user root Dec 11 12:30:27 volumio volumio[880]: info: FusionDsp - Reporting Fusion DSP Disabled Dec 11 12:30:27 volumio volumio[880]: info: Removing fusiondspeq DSP Signal Path Element Dec 11 12:30:27 volumio volumio[880]: info: Check plugin dependencies Dec 11 12:30:27 volumio volumio[880]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 11 12:30:27 volumio volumio[880]: info: Rename folder Dec 11 12:30:27 volumio volumio[880]: info: Folder /tmp/downloaded_plugin.zip removed Dec 11 12:30:27 volumio volumio[880]: info: Move to category Dec 11 12:30:27 volumio volumio[880]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 11 12:30:27 volumio volumio[880]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Dec 11 12:30:27 volumio volumio[880]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Dec 11 12:30:27 volumio volumio[880]: at onErrorNT (internal/child_process.js:465:16) Dec 11 12:30:27 volumio volumio[880]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Dec 11 12:30:27 volumio volumio[880]: errno: -2, Dec 11 12:30:27 volumio volumio[880]: code: 'ENOENT', Dec 11 12:30:27 volumio volumio[880]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Dec 11 12:30:27 volumio volumio[880]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Dec 11 12:30:27 volumio volumio[880]: spawnargs: [ Dec 11 12:30:27 volumio volumio[880]: '-p', Dec 11 12:30:27 volumio volumio[880]: 9876, Dec 11 12:30:27 volumio volumio[880]: '-o', Dec 11 12:30:27 volumio volumio[880]: '/tmp/camilladsp.log', Dec 11 12:30:27 volumio volumio[880]: '-l', Dec 11 12:30:27 volumio volumio[880]: 'warn', Dec 11 12:30:27 volumio volumio[880]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Dec 11 12:30:27 volumio volumio[880]: ] Dec 11 12:30:27 volumio volumio[880]: } Dec 11 12:30:27 volumio volumio[880]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 11 12:30:28 volumio sudo[9974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-11 12:29 Dec 11 12:30:28 volumio sudo[9974]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"