-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Fri 2026-01-09 18:19:16 UTC. -- Jan 09 18:18:43 volumio volumio[891]: info: Enabling plugin fusiondsp Jan 09 18:18:43 volumio volumio[891]: info: Loading plugin "fusiondsp"... Jan 09 18:18:43 volumio volumio[891]: info: Preparing to generate the ALSA configuration file Jan 09 18:18:43 volumio volumio[891]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 09 18:18:43 volumio volumio[891]: info: Reading ALSA contributions from plugins. Jan 09 18:18:43 volumio volumio[891]: info: Asound.conf file written Jan 09 18:18:43 volumio sudo[15354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jan 09 18:18:43 volumio sudo[15354]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:43 volumio sudo[15354]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:43 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:18:43 volumio volumio[891]: info: Output device has changed, restarting MPD Jan 09 18:18:44 volumio sudo[15359]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 18:18:44 volumio sudo[15359]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:44 volumio volumio[891]: info: Output device has changed, restarting Shairport Sync Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:18:44 volumio sudo[15359]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:44 volumio sudo[15361]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 18:18:44 volumio sudo[15361]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:44 volumio systemd[1]: Stopping Music Player Daemon... Jan 09 18:18:44 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:18:44 volumio volumio[891]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 18:18:44 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:18:44 volumio systemd[1]: mpd.service: Succeeded. Jan 09 18:18:44 volumio systemd[1]: Stopped Music Player Daemon. Jan 09 18:18:44 volumio systemd[1]: Starting Music Player Daemon... Jan 09 18:18:44 volumio volumio[891]: info: PLUGIN START: fusiondsp Jan 09 18:18:44 volumio volumio[891]: info: Loading i18n strings for locale en Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio sudo[15369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:18:44 volumio volumio[891]: info: FusionDsp - mixtype--------------------- None Jan 09 18:18:44 volumio sudo[15369]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:44 volumio volumio[891]: info: Preparing to generate the ALSA configuration file Jan 09 18:18:44 volumio volumio[891]: info: Done. Jan 09 18:18:44 volumio sudo[15369]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:44 volumio volumio[891]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 09 18:18:44 volumio volumio[891]: info: Reading ALSA contributions from plugins. Jan 09 18:18:44 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:18:44 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:18:44 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:18:44 volumio sudo[15373]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:18:44 volumio volumio[891]: info: MPD Permissions set Jan 09 18:18:44 volumio sudo[15373]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio sudo[15373]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: Starting Shairport Sync Jan 09 18:18:44 volumio volumio[891]: info: Asound.conf file unchanged, so no further update is needed Jan 09 18:18:44 volumio volumio[891]: info: Output device has changed, restarting MPD Jan 09 18:18:44 volumio sudo[15382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 18:18:44 volumio sudo[15382]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:44 volumio volumio[891]: info: Output device has changed, restarting Shairport Sync Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:18:44 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 09 18:18:44 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 09 18:18:44 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 09 18:18:44 volumio sudo[15385]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 18:18:44 volumio sudo[15385]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:44 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 09 18:18:44 volumio sudo[15385]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:44 volumio sudo[15382]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:44 volumio sudo[15389]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 18:18:44 volumio sudo[15389]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:44 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 09 18:18:44 volumio systemd[1]: mpd.service: Succeeded. Jan 09 18:18:44 volumio systemd[1]: Stopped Music Player Daemon. Jan 09 18:18:44 volumio systemd[1]: Starting Music Player Daemon... Jan 09 18:18:44 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:18:44 volumio volumio[891]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 18:18:44 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:18:44 volumio sudo[15400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:18:44 volumio sudo[15400]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:44 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:18:44 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:18:44 volumio sudo[15402]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:18:44 volumio sudo[15402]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:44 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:18:44 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:18:44 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:18:44 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:18:44 volumio volumio[891]: info: MPD Permissions set Jan 09 18:18:44 volumio volumio[891]: info: Shairport-Sync Started Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio sudo[15402]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:44 volumio sudo[15400]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:18:44 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:44 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:18:44 volumio volumio[891]: info: Starting Shairport Sync Jan 09 18:18:44 volumio sudo[15413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 18:18:44 volumio sudo[15413]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:44 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 09 18:18:44 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 09 18:18:44 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 09 18:18:44 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:18:44 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:18:44 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 09 18:18:44 volumio sudo[15413]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:44 volumio volumio[891]: info: Shairport-Sync Started Jan 09 18:18:45 volumio volumio[891]: info: Enabling plugin fusiondsp Jan 09 18:18:45 volumio volumio[891]: info: Loading plugin "fusiondsp"... Jan 09 18:18:45 volumio volumio[891]: info: Applying required configuration parameters for plugin fusiondsp Jan 09 18:18:45 volumio volumio[891]: info: Preparing to generate the ALSA configuration file Jan 09 18:18:45 volumio volumio[891]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 09 18:18:45 volumio volumio[891]: info: Reading ALSA contributions from plugins. Jan 09 18:18:45 volumio volumio[891]: info: Asound.conf file unchanged, so no further update is needed Jan 09 18:18:45 volumio volumio[891]: info: Output device has changed, restarting MPD Jan 09 18:18:45 volumio sudo[15420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 18:18:45 volumio sudo[15420]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:45 volumio volumio[891]: info: Output device has changed, restarting Shairport Sync Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:18:45 volumio sudo[15420]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:45 volumio sudo[15422]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 18:18:45 volumio sudo[15422]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:45 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 09 18:18:45 volumio systemd[1]: mpd.service: Succeeded. Jan 09 18:18:45 volumio systemd[1]: Stopped Music Player Daemon. Jan 09 18:18:45 volumio systemd[1]: Starting Music Player Daemon... Jan 09 18:18:45 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:18:45 volumio volumio[891]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 18:18:45 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:18:45 volumio volumio[891]: info: PLUGIN START: fusiondsp Jan 09 18:18:45 volumio volumio[891]: info: Loading i18n strings for locale en Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:45 volumio volumio[891]: info: FusionDsp - mixtype--------------------- None Jan 09 18:18:45 volumio volumio[891]: info: Preparing to generate the ALSA configuration file Jan 09 18:18:45 volumio sudo[15430]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:18:45 volumio sudo[15430]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:45 volumio volumio[891]: info: Done. Jan 09 18:18:45 volumio sudo[15430]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:45 volumio volumio[891]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 09 18:18:45 volumio volumio[891]: info: Reading ALSA contributions from plugins. Jan 09 18:18:45 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:18:45 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:18:45 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:18:45 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:18:45 volumio volumio[891]: info: MPD Permissions set Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:45 volumio sudo[15435]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:18:45 volumio sudo[15435]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:45 volumio volumio[891]: info: Starting Shairport Sync Jan 09 18:18:45 volumio sudo[15435]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:45 volumio volumio[891]: info: Asound.conf file unchanged, so no further update is needed Jan 09 18:18:45 volumio volumio[891]: info: Output device has changed, restarting MPD Jan 09 18:18:45 volumio sudo[15443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 18:18:45 volumio sudo[15443]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:45 volumio volumio[891]: info: Output device has changed, restarting Shairport Sync Jan 09 18:18:45 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:45 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:18:45 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 09 18:18:45 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 09 18:18:45 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 09 18:18:45 volumio sudo[15449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 18:18:45 volumio sudo[15449]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:45 volumio sudo[15448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 18:18:45 volumio sudo[15448]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:45 volumio sudo[15443]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:45 volumio sudo[15448]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:45 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 09 18:18:45 volumio systemd[1]: mpd.service: Succeeded. Jan 09 18:18:45 volumio systemd[1]: Stopped Music Player Daemon. Jan 09 18:18:45 volumio systemd[1]: Starting Music Player Daemon... Jan 09 18:18:45 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:18:45 volumio volumio[891]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 18:18:45 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:18:45 volumio sudo[15460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:18:45 volumio sudo[15460]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:46 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:18:46 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:18:46 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:18:46 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:18:46 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:18:46 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:18:46 volumio volumio[891]: info: MPD Permissions set Jan 09 18:18:46 volumio volumio[891]: info: Shairport-Sync Started Jan 09 18:18:46 volumio sudo[15463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:18:46 volumio sudo[15463]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:46 volumio sudo[15460]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:46 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:46 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:46 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:46 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:46 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:46 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:46 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:46 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:46 volumio sudo[15463]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:46 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:18:46 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:46 volumio volumio[891]: info: Starting Shairport Sync Jan 09 18:18:46 volumio sudo[15473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 18:18:46 volumio sudo[15473]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:46 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 09 18:18:46 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 09 18:18:46 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 09 18:18:46 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 09 18:18:46 volumio sudo[15473]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:46 volumio volumio[891]: info: camilladsp service started and running in background, instance 1 Jan 09 18:18:46 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:46 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:18:46 volumio volumio[891]: info: FusionDsp - AAAAAAAAAAAAAA-> 22050 44100 48000 88200 96000 176400 192000 <-AAAAAAAAAAAAA Jan 09 18:18:46 volumio volumio[891]: info: FusionDsp loaded Jan 09 18:18:46 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 18:18:46 volumio sudo[15491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jan 09 18:18:46 volumio sudo[15491]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:46 volumio volumio[891]: info: FusionDsp - Reporting Fusion DSP Enabled Jan 09 18:18:46 volumio systemd[1]: Started FusionDsp Daemon. Jan 09 18:18:46 volumio volumio[891]: info: FusionDsp - ---- installed callbackRead Jan 09 18:18:46 volumio volumio[891]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 09 18:18:46 volumio sudo[15491]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:46 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:18:46 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:18:46 volumio volumio[891]: info: Shairport-Sync Started Jan 09 18:18:46 volumio volumio[891]: error: FusionDsp - WebSocket error: [object Object] Jan 09 18:18:46 volumio volumio[891]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Jan 09 18:18:47 volumio volumio[891]: info: TidalConnect service stoped! Jan 09 18:18:47 volumio volumio[891]: info: TidalConnect service stoped! Jan 09 18:18:47 volumio mpd[15477]: Jan 09 18:18 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 09 18:18:47 volumio mpd[15477]: Jan 09 18:18 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jan 09 18:18:47 volumio mpd[15477]: Jan 09 18:18 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jan 09 18:18:47 volumio systemd[1]: Started Music Player Daemon. Jan 09 18:18:47 volumio sudo[15361]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:47 volumio sudo[15422]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:47 volumio sudo[15449]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:47 volumio sudo[15389]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:47 volumio volumio[891]: error: MPD error: The expression evaluated to a falsy value: Jan 09 18:18:47 volumio volumio[891]: assert.ok(self.idling) Jan 09 18:18:47 volumio volumio[891]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:18:47 volumio volumio[891]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:18:47 volumio volumio[891]: 0+0 records in Jan 09 18:18:47 volumio volumio[891]: 0+0 records out Jan 09 18:18:47 volumio volumio[891]: 0 bytes copied, 0.000161405 s, 0.0 kB/s Jan 09 18:18:47 volumio volumio[891]: error: MPD error: The expression evaluated to a falsy value: Jan 09 18:18:47 volumio volumio[891]: assert.ok(self.idling) Jan 09 18:18:47 volumio volumio[891]: error: MPD error: The expression evaluated to a falsy value: Jan 09 18:18:47 volumio volumio[891]: assert.ok(self.idling) Jan 09 18:18:47 volumio volumio[891]: error: updateQueue error: null Jan 09 18:18:47 volumio sudo[15514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 09 18:18:47 volumio sudo[15514]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:47 volumio systemd[1]: Started Volumio Tidal Connect Service. Jan 09 18:18:47 volumio sudo[15514]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:47 volumio volumio[891]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jan 09 18:18:47 volumio volumio[891]: 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 Jan 09 18:18:47 volumio volumio[891]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jan 09 18:18:47 volumio volumio[891]: info: camilladsp service started and running in background, instance 2 Jan 09 18:18:47 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:18:47 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:18:47 volumio volumio[891]: cannot open device 'volumioHw': Device or resource busy Jan 09 18:18:47 volumio volumio[891]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jan 09 18:18:47 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:18:47 volumio volumio[891]: cannot open device 'volumioHw': Device or resource busy Jan 09 18:18:47 volumio volumio[891]: info: FusionDsp loaded Jan 09 18:18:47 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 18:18:47 volumio volumio[891]: info: FusionDsp - Reporting Fusion DSP Enabled Jan 09 18:18:47 volumio volumio[891]: info: FusionDsp - ---- installed callbackRead Jan 09 18:18:47 volumio volumio[891]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 09 18:18:47 volumio volumio[891]: info: FusionDsp - ---- read samplerate, raw: Jan 09 18:18:47 volumio volumio[891]: error: FusionDsp - invalid sample rate Jan 09 18:18:47 volumio volumio[891]: info: FusionDsp - ---- read samplerate, raw: Jan 09 18:18:47 volumio sudo[15535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jan 09 18:18:47 volumio sudo[15535]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:47 volumio volumio[891]: error: FusionDsp - invalid sample rate Jan 09 18:18:47 volumio volumio[891]: info: TidalConnect service stoped! Jan 09 18:18:47 volumio volumio[891]: info: TidalConnect service stoped! Jan 09 18:18:47 volumio sudo[15535]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:47 volumio volumio[891]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 8 Jan 09 18:18:47 volumio volumio[891]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 09 18:18:47 volumio volumio[891]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:18:47 volumio volumio[891]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:18:47 volumio volumio[891]: info: Executing endpoint tc_getconfig Jan 09 18:18:47 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 09 18:18:47 volumio sudo[15562]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 09 18:18:48 volumio vtcs[15516]: BYE Jan 09 18:18:48 volumio sudo[15562]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:48 volumio systemd[1]: vtcs.service: Succeeded. Jan 09 18:18:48 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:18:48 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Jan 09 18:18:48 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 1. Jan 09 18:18:48 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jan 09 18:18:48 volumio systemd[1]: Started Volumio Tidal Connect Service. Jan 09 18:18:48 volumio sudo[15562]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:48 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:18:48 volumio volumio[891]: info: Executing endpoint tc_getconfig Jan 09 18:18:48 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 09 18:18:48 volumio vtcs[15600]: BYE Jan 09 18:18:48 volumio systemd[1]: vtcs.service: Succeeded. Jan 09 18:18:48 volumio volumio[891]: info: TidalConnect service stoped! Jan 09 18:18:48 volumio volumio[891]: info: TidalConnect service stoped! Jan 09 18:18:48 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Jan 09 18:18:48 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 2. Jan 09 18:18:48 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jan 09 18:18:48 volumio systemd[1]: Started Volumio Tidal Connect Service. Jan 09 18:18:48 volumio volumio[891]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:18:48 volumio volumio[891]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:18:48 volumio sudo[15678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 09 18:18:48 volumio sudo[15678]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:48 volumio sudo[15678]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:49 volumio volumio[891]: info: TidalConnect service stoped! Jan 09 18:18:49 volumio volumio[891]: info: Executing endpoint tc_getconfig Jan 09 18:18:49 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 09 18:18:49 volumio vtcs[15669]: BYE Jan 09 18:18:49 volumio volumio[891]: info: TidalConnect service stoped! Jan 09 18:18:49 volumio systemd[1]: vtcs.service: Succeeded. Jan 09 18:18:49 volumio volumio[891]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:18:49 volumio volumio[891]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:18:49 volumio sudo[15726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 09 18:18:49 volumio sudo[15726]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:18:49 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Jan 09 18:18:49 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 3. Jan 09 18:18:49 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jan 09 18:18:49 volumio systemd[1]: Started Volumio Tidal Connect Service. Jan 09 18:18:49 volumio sudo[15726]: pam_unix(sudo:session): session closed for user root Jan 09 18:18:49 volumio volumio[891]: info: Executing endpoint tc_getconfig Jan 09 18:18:49 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 09 18:18:49 volumio vtcs[15735]: BYE Jan 09 18:18:49 volumio systemd[1]: vtcs.service: Succeeded. Jan 09 18:18:49 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Jan 09 18:18:49 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 4. Jan 09 18:18:49 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jan 09 18:18:49 volumio systemd[1]: Started Volumio Tidal Connect Service. Jan 09 18:18:50 volumio volumio[891]: info: Executing endpoint tc_getconfig Jan 09 18:18:50 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 09 18:18:50 volumio vtcs[15796]: BYE Jan 09 18:18:50 volumio systemd[1]: vtcs.service: Succeeded. Jan 09 18:18:50 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Jan 09 18:18:50 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 5. Jan 09 18:18:50 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jan 09 18:18:50 volumio systemd[1]: vtcs.service: Start request repeated too quickly. Jan 09 18:18:50 volumio systemd[1]: vtcs.service: Failed with result 'start-limit-hit'. Jan 09 18:18:50 volumio systemd[1]: Failed to start Volumio Tidal Connect Service. Jan 09 18:18:50 volumio volumio[891]: info: TidalConnect service started! Jan 09 18:18:51 volumio volumio[891]: info: TidalConnect service started! Jan 09 18:18:51 volumio volumio[891]: info: TidalConnect service started! Jan 09 18:18:52 volumio volumio[891]: info: TidalConnect service started! Jan 09 18:18:52 volumio volumio[891]: error: updateQueue error: null Jan 09 18:18:52 volumio volumio[891]: error: updateQueue error: null Jan 09 18:18:52 volumio volumio[891]: error: updateQueue error: null Jan 09 18:19:03 volumio volumio[891]: info: Enabling plugin fusiondsp Jan 09 18:19:03 volumio volumio[891]: info: Loading plugin "fusiondsp"... Jan 09 18:19:03 volumio volumio[891]: info: Applying required configuration parameters for plugin fusiondsp Jan 09 18:19:03 volumio volumio[891]: info: Preparing to generate the ALSA configuration file Jan 09 18:19:03 volumio volumio[891]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 09 18:19:03 volumio volumio[891]: info: Reading ALSA contributions from plugins. Jan 09 18:19:03 volumio volumio[891]: info: Asound.conf file unchanged, so no further update is needed Jan 09 18:19:03 volumio volumio[891]: info: Output device has changed, restarting MPD Jan 09 18:19:03 volumio sudo[17614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 18:19:03 volumio volumio[891]: info: Output device has changed, restarting Shairport Sync Jan 09 18:19:03 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:19:03 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:19:03 volumio sudo[17614]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:19:03 volumio sudo[17614]: pam_unix(sudo:session): session closed for user root Jan 09 18:19:03 volumio sudo[17616]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 18:19:03 volumio sudo[17616]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:19:03 volumio systemd[1]: Stopping Music Player Daemon... Jan 09 18:19:03 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:19:03 volumio volumio[891]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 18:19:03 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:19:03 volumio systemd[1]: mpd.service: Succeeded. Jan 09 18:19:03 volumio systemd[1]: Stopped Music Player Daemon. Jan 09 18:19:03 volumio systemd[1]: Starting Music Player Daemon... Jan 09 18:19:03 volumio volumio[891]: info: PLUGIN START: fusiondsp Jan 09 18:19:03 volumio volumio[891]: info: Loading i18n strings for locale en Jan 09 18:19:03 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 09 18:19:03 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:19:03 volumio volumio[891]: info: FusionDsp - mixtype--------------------- None Jan 09 18:19:03 volumio volumio[891]: info: Preparing to generate the ALSA configuration file Jan 09 18:19:03 volumio sudo[17624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:19:03 volumio sudo[17624]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:19:03 volumio volumio[891]: info: Done. Jan 09 18:19:03 volumio sudo[17624]: pam_unix(sudo:session): session closed for user root Jan 09 18:19:03 volumio volumio[891]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 09 18:19:03 volumio volumio[891]: info: Reading ALSA contributions from plugins. Jan 09 18:19:03 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:19:03 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:19:03 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:19:03 volumio volumio[891]: info: MPD Permissions set Jan 09 18:19:03 volumio sudo[17628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:19:03 volumio sudo[17628]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:19:03 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:19:03 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:19:03 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:19:03 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:19:03 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:19:03 volumio sudo[17628]: pam_unix(sudo:session): session closed for user root Jan 09 18:19:03 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:19:03 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:19:03 volumio volumio[891]: info: Starting Shairport Sync Jan 09 18:19:04 volumio volumio[891]: info: Asound.conf file unchanged, so no further update is needed Jan 09 18:19:04 volumio volumio[891]: info: Output device has changed, restarting MPD Jan 09 18:19:04 volumio sudo[17644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 18:19:04 volumio sudo[17644]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:19:04 volumio volumio[891]: info: Output device has changed, restarting Shairport Sync Jan 09 18:19:04 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:19:04 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:19:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 09 18:19:04 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 09 18:19:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 09 18:19:04 volumio sudo[17650]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 09 18:19:04 volumio sudo[17650]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:19:04 volumio sudo[17648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 09 18:19:04 volumio sudo[17648]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:19:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 09 18:19:04 volumio sudo[17648]: pam_unix(sudo:session): session closed for user root Jan 09 18:19:04 volumio sudo[17644]: pam_unix(sudo:session): session closed for user root Jan 09 18:19:04 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 09 18:19:04 volumio systemd[1]: mpd.service: Succeeded. Jan 09 18:19:04 volumio systemd[1]: Stopped Music Player Daemon. Jan 09 18:19:04 volumio systemd[1]: Starting Music Player Daemon... Jan 09 18:19:04 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:19:04 volumio volumio[891]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 09 18:19:04 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:19:04 volumio sudo[17662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:19:04 volumio sudo[17662]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:19:04 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:19:04 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:19:04 volumio sudo[17665]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jan 09 18:19:04 volumio sudo[17665]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:19:04 volumio sudo[17662]: pam_unix(sudo:session): session closed for user root Jan 09 18:19:04 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:19:04 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:19:04 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:19:04 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:19:04 volumio volumio[891]: info: MPD Permissions set Jan 09 18:19:04 volumio volumio[891]: info: Shairport-Sync Started Jan 09 18:19:04 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:19:04 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:19:04 volumio sudo[17665]: pam_unix(sudo:session): session closed for user root Jan 09 18:19:04 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 18:19:04 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:19:04 volumio volumio[891]: info: Starting Shairport Sync Jan 09 18:19:04 volumio sudo[17689]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 09 18:19:04 volumio sudo[17689]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:19:04 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 09 18:19:04 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 09 18:19:04 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 09 18:19:04 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 09 18:19:04 volumio sudo[17689]: pam_unix(sudo:session): session closed for user root Jan 09 18:19:04 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:19:04 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:19:04 volumio volumio[891]: info: Shairport-Sync Started Jan 09 18:19:05 volumio mpd[17690]: Jan 09 18:19 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 09 18:19:05 volumio mpd[17690]: Jan 09 18:19 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jan 09 18:19:05 volumio mpd[17690]: Jan 09 18:19 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jan 09 18:19:05 volumio systemd[1]: Started Music Player Daemon. Jan 09 18:19:05 volumio sudo[17650]: pam_unix(sudo:session): session closed for user root Jan 09 18:19:05 volumio sudo[17616]: pam_unix(sudo:session): session closed for user root Jan 09 18:19:05 volumio volumio[891]: error: MPD error: The expression evaluated to a falsy value: Jan 09 18:19:05 volumio volumio[891]: assert.ok(self.idling) Jan 09 18:19:05 volumio volumio[891]: error: updateQueue error: null Jan 09 18:19:05 volumio volumio[891]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jan 09 18:19:05 volumio volumio[891]: 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 Jan 09 18:19:05 volumio volumio[891]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jan 09 18:19:05 volumio volumio[891]: info: camilladsp service started and running in background, instance 3 Jan 09 18:19:05 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 18:19:05 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:19:05 volumio volumio[891]: cannot open device 'volumioHw': Device or resource busy Jan 09 18:19:05 volumio volumio[891]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jan 09 18:19:05 volumio volumio[891]: xcb_connection_has_error() returned true Jan 09 18:19:05 volumio volumio[891]: cannot open device 'volumioHw': Device or resource busy Jan 09 18:19:05 volumio volumio[891]: info: FusionDsp loaded Jan 09 18:19:05 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 18:19:05 volumio volumio[891]: info: FusionDsp - Reporting Fusion DSP Enabled Jan 09 18:19:05 volumio volumio[891]: info: FusionDsp - ---- installed callbackRead Jan 09 18:19:05 volumio volumio[891]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jan 09 18:19:05 volumio sudo[17888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jan 09 18:19:05 volumio sudo[17888]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:19:06 volumio volumio[891]: info: FusionDsp - ---- read samplerate, raw: Jan 09 18:19:06 volumio volumio[891]: error: FusionDsp - invalid sample rate Jan 09 18:19:06 volumio volumio[891]: info: FusionDsp - ---- read samplerate, raw: Jan 09 18:19:06 volumio volumio[891]: error: FusionDsp - invalid sample rate Jan 09 18:19:06 volumio volumio[891]: info: FusionDsp - ---- read samplerate, raw: Jan 09 18:19:06 volumio volumio[891]: error: FusionDsp - invalid sample rate Jan 09 18:19:06 volumio sudo[17888]: pam_unix(sudo:session): session closed for user root Jan 09 18:19:06 volumio volumio[891]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Jan 09 18:19:06 volumio volumio[891]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jan 09 18:19:06 volumio volumio[891]: info: TidalConnect service stoped! Jan 09 18:19:06 volumio volumio[891]: info: TidalConnect service stoped! Jan 09 18:19:07 volumio volumio[891]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:19:07 volumio volumio[891]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:19:07 volumio sudo[18145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 09 18:19:07 volumio sudo[18145]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:19:07 volumio systemd[1]: Started Volumio Tidal Connect Service. Jan 09 18:19:07 volumio sudo[18145]: pam_unix(sudo:session): session closed for user root Jan 09 18:19:07 volumio volumio[891]: info: TidalConnect service stoped! Jan 09 18:19:07 volumio volumio[891]: info: TidalConnect service stoped! Jan 09 18:19:07 volumio volumio[891]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:19:07 volumio volumio[891]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jan 09 18:19:07 volumio volumio[891]: info: Executing endpoint tc_getconfig Jan 09 18:19:07 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 09 18:19:07 volumio vtcs[18155]: BYE Jan 09 18:19:07 volumio systemd[1]: vtcs.service: Succeeded. Jan 09 18:19:07 volumio sudo[18223]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jan 09 18:19:07 volumio sudo[18223]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:19:07 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:19:07 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Jan 09 18:19:07 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 1. Jan 09 18:19:07 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jan 09 18:19:07 volumio systemd[1]: Started Volumio Tidal Connect Service. Jan 09 18:19:07 volumio sudo[18223]: pam_unix(sudo:session): session closed for user root Jan 09 18:19:07 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jan 09 18:19:08 volumio volumio[891]: info: Executing endpoint tc_getconfig Jan 09 18:19:08 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 09 18:19:08 volumio vtcs[18296]: BYE Jan 09 18:19:08 volumio systemd[1]: vtcs.service: Succeeded. Jan 09 18:19:08 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Jan 09 18:19:08 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 2. Jan 09 18:19:08 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jan 09 18:19:08 volumio systemd[1]: Started Volumio Tidal Connect Service. Jan 09 18:19:08 volumio volumio[891]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Jan 09 18:19:08 volumio volumio[891]: info: Executing endpoint tc_getconfig Jan 09 18:19:08 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 09 18:19:08 volumio vtcs[18398]: BYE Jan 09 18:19:08 volumio systemd[1]: vtcs.service: Succeeded. Jan 09 18:19:08 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Jan 09 18:19:08 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 3. Jan 09 18:19:08 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jan 09 18:19:08 volumio systemd[1]: Started Volumio Tidal Connect Service. Jan 09 18:19:09 volumio volumio[891]: info: Executing endpoint tc_getconfig Jan 09 18:19:09 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 09 18:19:09 volumio vtcs[18500]: BYE Jan 09 18:19:09 volumio systemd[1]: vtcs.service: Succeeded. Jan 09 18:19:09 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Jan 09 18:19:09 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 4. Jan 09 18:19:09 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jan 09 18:19:09 volumio systemd[1]: Started Volumio Tidal Connect Service. Jan 09 18:19:09 volumio volumio[891]: info: Executing endpoint tc_getconfig Jan 09 18:19:09 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jan 09 18:19:09 volumio vtcs[18597]: BYE Jan 09 18:19:09 volumio systemd[1]: vtcs.service: Succeeded. Jan 09 18:19:09 volumio systemd[1]: vtcs.service: Service RestartSec=100ms expired, scheduling restart. Jan 09 18:19:09 volumio systemd[1]: vtcs.service: Scheduled restart job, restart counter is at 5. Jan 09 18:19:09 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jan 09 18:19:09 volumio systemd[1]: vtcs.service: Start request repeated too quickly. Jan 09 18:19:09 volumio systemd[1]: vtcs.service: Failed with result 'start-limit-hit'. Jan 09 18:19:09 volumio systemd[1]: Failed to start Volumio Tidal Connect Service. Jan 09 18:19:10 volumio volumio[891]: info: TidalConnect service started! Jan 09 18:19:10 volumio volumio[891]: error: updateQueue error: null Jan 09 18:19:10 volumio volumio[891]: info: TidalConnect service started! Jan 09 18:19:15 volumio volumio[891]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Jan 09 18:19:15 volumio volumio[891]: info: FusionDsp - Stopping FusionDsp service Jan 09 18:19:15 volumio volumio[891]: info: camilladsp stopping service pid 19983... Jan 09 18:19:15 volumio volumio[891]: info: camilladsp service terminated, instance 3 Jan 09 18:19:15 volumio sudo[19993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Jan 09 18:19:15 volumio sudo[19993]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 18:19:15 volumio systemd[1]: Stopping FusionDsp Daemon... Jan 09 18:19:15 volumio volumio[15493]: Backend configuration: Jan 09 18:19:15 volumio volumio[15493]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Jan 09 18:19:15 volumio volumio[15493]: active_config_txt: null Jan 09 18:19:15 volumio volumio[15493]: camilla_host: 127.0.0.1 Jan 09 18:19:15 volumio volumio[15493]: camilla_port: 9876 Jan 09 18:19:15 volumio volumio[15493]: coeff_dir: /data/INTERNAL/FusionDsp/filters Jan 09 18:19:15 volumio volumio[15493]: config_dir: /data/configuration/audio_interface/fusiondsp Jan 09 18:19:15 volumio volumio[15493]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Jan 09 18:19:15 volumio volumio[15493]: log_file: /tmp/camilladsp.log Jan 09 18:19:15 volumio volumio[15493]: on_get_active_config: null Jan 09 18:19:15 volumio volumio[15493]: on_set_active_config: null Jan 09 18:19:15 volumio volumio[15493]: port: 5011 Jan 09 18:19:15 volumio volumio[15493]: supported_capture_types: null Jan 09 18:19:15 volumio volumio[15493]: supported_playback_types: null Jan 09 18:19:15 volumio volumio[15493]: update_config_symlink: false Jan 09 18:19:15 volumio volumio[15493]: update_config_txt: false Jan 09 18:19:15 volumio volumio[15493]: ======== Running on http://0.0.0.0:5011 ======== Jan 09 18:19:15 volumio volumio[15493]: (Press CTRL+C to quit) Jan 09 18:19:15 volumio volumio[891]: ------------------------------------ BT MESSAGE: BT STATUS: running Jan 09 18:19:15 volumio systemd[1]: fusiondsp.service: Succeeded. Jan 09 18:19:15 volumio systemd[1]: Stopped FusionDsp Daemon. Jan 09 18:19:15 volumio sudo[19993]: pam_unix(sudo:session): session closed for user root Jan 09 18:19:15 volumio volumio[891]: info: FusionDsp - Reporting Fusion DSP Disabled Jan 09 18:19:16 volumio volumio[891]: info: Check plugin dependencies Jan 09 18:19:16 volumio volumio[891]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 18:19:16 volumio volumio[891]: info: Rename folder Jan 09 18:19:16 volumio volumio[891]: info: Folder /tmp/downloaded_plugin.zip removed Jan 09 18:19:16 volumio volumio[891]: info: Move to category Jan 09 18:19:16 volumio volumio[891]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 18:19:16 volumio volumio[891]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jan 09 18:19:16 volumio volumio[891]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jan 09 18:19:16 volumio volumio[891]: at onErrorNT (internal/child_process.js:465:16) Jan 09 18:19:16 volumio volumio[891]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Jan 09 18:19:16 volumio volumio[891]: errno: -2, Jan 09 18:19:16 volumio volumio[891]: code: 'ENOENT', Jan 09 18:19:16 volumio volumio[891]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jan 09 18:19:16 volumio volumio[891]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jan 09 18:19:16 volumio volumio[891]: spawnargs: [ Jan 09 18:19:16 volumio volumio[891]: '-p', Jan 09 18:19:16 volumio volumio[891]: 9876, Jan 09 18:19:16 volumio volumio[891]: '-o', Jan 09 18:19:16 volumio volumio[891]: '/tmp/camilladsp.log', Jan 09 18:19:16 volumio volumio[891]: '-l', Jan 09 18:19:16 volumio volumio[891]: 'warn', Jan 09 18:19:16 volumio volumio[891]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jan 09 18:19:16 volumio volumio[891]: ] Jan 09 18:19:16 volumio volumio[891]: } Jan 09 18:19:16 volumio volumio[891]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 18:19:16 volumio sudo[20079]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-09 18:18 Jan 09 18:19:16 volumio sudo[20079]: 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="91e88ea6c5c4ec4f00aff63f7c3a2944b14ec939" VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463" VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7" VOLUMIO_BE_VERSION="85acf7bbbceb3e3dec447156a39a88033f921210" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 30 Sep 2022 10:43:40 AM CEST" VOLUMIO_VERSION="3.378" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4bc817297375b72097a1fade15c6518b"