-- Logs begin at Thu 2024-07-18 14:27:49 IST, end at Thu 2024-07-18 14:35:26 IST. -- Jul 18 14:34:23 srimusic volumio[807]: verbose: New Socket.io Connection to 192.168.1.189 from 192.168.1.11 UA: unknown Engine version: 3 Transport: websocket Total Clients: 6 Jul 18 14:34:23 srimusic volumio[807]: info: CoreCommandRouter::volumioGetState Jul 18 14:34:23 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 18 14:34:23 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 18 14:34:23 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 18 14:34:23 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 18 14:34:23 srimusic volumio[807]: info: Discovery: Getting this device information Jul 18 14:34:23 srimusic volumio[807]: info: CoreCommandRouter::volumioGetState Jul 18 14:34:23 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 18 14:34:24 srimusic volumio[807]: verbose: New Socket.io Connection to 192.168.1.189 from 192.168.1.11 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Jul 18 14:34:24 srimusic volumio[807]: info: Received Get System Info Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 18 14:34:24 srimusic volumio[807]: info: Discovery: Getting this device information Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::volumioGetState Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::volumioGetState Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::volumioGetVisibleSources Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::volumioGetState Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 18 14:34:24 srimusic volumio[807]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 18 14:34:24 srimusic volumio[807]: info: Received Get System Info Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 18 14:34:24 srimusic volumio[807]: info: Discovery: Getting this device information Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::volumioGetState Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::volumioGetState Jul 18 14:34:24 srimusic volumio[807]: info: Listing playlists Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::volumioGetQueue Jul 18 14:34:24 srimusic volumio[807]: info: CoreStateMachine::getQueue Jul 18 14:34:24 srimusic volumio[807]: info: CorePlayQueue::getQueue Jul 18 14:34:24 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 18 14:34:32 srimusic volumio[807]: info: Enabling plugin fusiondsp Jul 18 14:34:32 srimusic volumio[807]: info: Loading plugin "fusiondsp"... Jul 18 14:34:33 srimusic volumio[807]: info: Preparing to generate the ALSA configuration file Jul 18 14:34:33 srimusic volumio[807]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 18 14:34:33 srimusic volumio[807]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 18 14:34:33 srimusic volumio[807]: info: Reading ALSA contributions from plugins. Jul 18 14:34:33 srimusic volumio[807]: info: Asound.conf file unchanged, so no further update is needed Jul 18 14:34:33 srimusic volumio[807]: info: Output device has changed, restarting MPD Jul 18 14:34:33 srimusic sudo[2594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 18 14:34:33 srimusic sudo[2594]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:34:33 srimusic sudo[2594]: pam_unix(sudo:session): session closed for user root Jul 18 14:34:33 srimusic volumio[807]: info: Output device has changed, restarting Shairport Sync Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 14:34:33 srimusic sudo[2598]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 18 14:34:33 srimusic sudo[2598]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:34:33 srimusic systemd[1]: Stopping Music Player Daemon... Jul 18 14:34:33 srimusic systemd[1]: mpd.service: Succeeded. Jul 18 14:34:33 srimusic volumio[807]: No protocol specified Jul 18 14:34:33 srimusic volumio[807]: xcb_connection_has_error() returned true Jul 18 14:34:33 srimusic volumio[807]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 18 14:34:33 srimusic volumio[807]: No protocol specified Jul 18 14:34:33 srimusic volumio[807]: xcb_connection_has_error() returned true Jul 18 14:34:33 srimusic systemd[1]: Stopped Music Player Daemon. Jul 18 14:34:33 srimusic volumio[807]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:33 srimusic vtcs[2088]: [2024-07-18 14:34:33.671] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Jul 18 14:34:33 srimusic vtcs[2088]: [2024-07-18 14:34:33.671] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Jul 18 14:34:33 srimusic systemd[1]: Starting Music Player Daemon... Jul 18 14:34:33 srimusic volumio[807]: info: PLUGIN START: fusiondsp Jul 18 14:34:33 srimusic volumio[807]: info: Loading i18n strings for locale en Jul 18 14:34:33 srimusic sudo[2608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 18 14:34:33 srimusic sudo[2608]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:33 srimusic volumio[807]: info: FusionDsp - mixtype--------------------- Software Jul 18 14:34:33 srimusic volumio[807]: info: Preparing to generate the ALSA configuration file Jul 18 14:34:33 srimusic systemd[1]: Stopping Volumio Tidal Connect Service... Jul 18 14:34:33 srimusic volumio[807]: info: Done. Jul 18 14:34:33 srimusic systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jul 18 14:34:33 srimusic systemd[1]: vtcs.service: Succeeded. Jul 18 14:34:33 srimusic systemd[1]: Stopped Volumio Tidal Connect Service. Jul 18 14:34:33 srimusic sudo[2608]: pam_unix(sudo:session): session closed for user root Jul 18 14:34:33 srimusic volumio[807]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 18 14:34:33 srimusic volumio[807]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 18 14:34:33 srimusic volumio[807]: info: Reading ALSA contributions from plugins. Jul 18 14:34:33 srimusic volumio[807]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 18 14:34:33 srimusic volumio[807]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 18 14:34:33 srimusic sudo[2612]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 18 14:34:33 srimusic sudo[2603]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 18 14:34:33 srimusic sudo[2612]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:34:33 srimusic sudo[2603]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:34:33 srimusic volumio[807]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 18 14:34:33 srimusic sudo[2603]: pam_unix(sudo:session): session closed for user root Jul 18 14:34:33 srimusic volumio[807]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 18 14:34:33 srimusic volumio[807]: info: MPD Permissions set Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:33 srimusic sudo[2612]: pam_unix(sudo:session): session closed for user root Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 14:34:33 srimusic volumio[807]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 14:34:33 srimusic volumio[807]: info: Starting Shairport Sync Jul 18 14:34:33 srimusic sudo[2624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 18 14:34:33 srimusic sudo[2624]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:34:33 srimusic systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 18 14:34:33 srimusic systemd[1]: shairport-sync.service: Succeeded. Jul 18 14:34:33 srimusic systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 18 14:34:33 srimusic systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 18 14:34:33 srimusic sudo[2624]: pam_unix(sudo:session): session closed for user root Jul 18 14:34:34 srimusic volumio[807]: info: Asound.conf file unchanged, so no further update is needed Jul 18 14:34:34 srimusic volumio[807]: info: Output device has changed, restarting MPD Jul 18 14:34:34 srimusic sudo[2632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 18 14:34:34 srimusic sudo[2632]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:34:34 srimusic sudo[2632]: pam_unix(sudo:session): session closed for user root Jul 18 14:34:34 srimusic volumio[807]: info: Output device has changed, restarting Shairport Sync Jul 18 14:34:34 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:34 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 14:34:34 srimusic sudo[2635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 18 14:34:34 srimusic sudo[2635]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:34:34 srimusic systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 18 14:34:34 srimusic systemd[1]: mpd.service: Succeeded. Jul 18 14:34:34 srimusic systemd[1]: Stopped Music Player Daemon. Jul 18 14:34:34 srimusic volumio[807]: No protocol specified Jul 18 14:34:34 srimusic volumio[807]: xcb_connection_has_error() returned true Jul 18 14:34:34 srimusic volumio[807]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 18 14:34:34 srimusic volumio[807]: No protocol specified Jul 18 14:34:34 srimusic volumio[807]: xcb_connection_has_error() returned true Jul 18 14:34:34 srimusic volumio[807]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 18 14:34:34 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:34 srimusic systemd[1]: Starting Music Player Daemon... Jul 18 14:34:34 srimusic volumio[807]: info: Preparing to generate the ALSA configuration file Jul 18 14:34:34 srimusic sudo[2644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 18 14:34:34 srimusic sudo[2644]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:34:34 srimusic sudo[2644]: pam_unix(sudo:session): session closed for user root Jul 18 14:34:34 srimusic sudo[2640]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 18 14:34:34 srimusic sudo[2640]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:34:34 srimusic sudo[2648]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 18 14:34:34 srimusic sudo[2648]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:34:34 srimusic sudo[2640]: pam_unix(sudo:session): session closed for user root Jul 18 14:34:34 srimusic sudo[2648]: pam_unix(sudo:session): session closed for user root Jul 18 14:34:34 srimusic volumio[807]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 18 14:34:34 srimusic volumio[807]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 18 14:34:34 srimusic volumio[807]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 18 14:34:34 srimusic volumio[807]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 18 14:34:34 srimusic volumio[807]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 18 14:34:34 srimusic volumio[807]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 18 14:34:34 srimusic volumio[807]: info: Shairport-Sync Started Jul 18 14:34:34 srimusic volumio[807]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jul 18 14:34:34 srimusic volumio[807]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 18 14:34:34 srimusic volumio[807]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 18 14:34:34 srimusic volumio[807]: info: Reading ALSA contributions from plugins. Jul 18 14:34:34 srimusic volumio[807]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 18 14:34:34 srimusic volumio[807]: info: MPD Permissions set Jul 18 14:34:34 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:34 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:34 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:34 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:34 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:34 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:34 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:34 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:34 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 14:34:34 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 18 14:34:34 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:34:34 srimusic volumio[807]: info: Starting Shairport Sync Jul 18 14:34:34 srimusic sudo[2660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 18 14:34:34 srimusic sudo[2660]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:34:34 srimusic volumio[807]: info: Asound.conf file written Jul 18 14:34:34 srimusic systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 18 14:34:34 srimusic systemd[1]: shairport-sync.service: Succeeded. Jul 18 14:34:34 srimusic systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 18 14:34:34 srimusic sudo[2664]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 18 14:34:34 srimusic sudo[2664]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:34:34 srimusic sudo[2664]: pam_unix(sudo:session): session closed for user root Jul 18 14:34:34 srimusic systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 18 14:34:34 srimusic sudo[2660]: pam_unix(sudo:session): session closed for user root Jul 18 14:34:34 srimusic mpd[2651]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 18 14:34:34 srimusic mpd[2651]: output: No 'audio_output' defined in config file Jul 18 14:34:37 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:780:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer failed an mmap write to the the target pcm softvolume. 0 frames were written Jul 18 14:34:37 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:818:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer has not transferred a full period to the target pcm softvolume. 0 frames were written Jul 18 14:34:37 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: under-run Jul 18 14:34:37 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:34:37 srimusic mpd[2651]: couldn't open play stream: Device or resource busy Jul 18 14:34:37 srimusic mpd[2651]: sndio_output: Error opening default sndio device Jul 18 14:34:37 srimusic mpd[2651]: ALSA lib /home/volumio-fifo-plugin/src/pcm_volumiofifo.c:753:(_snd_pcm_volumiofifo_open) Failed to open output fifo /tmp/fusiondspfifo Jul 18 14:34:37 srimusic mpd[2651]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:143:(_snd_pcm_volumioswitch_open_target_pcm) PCM Volumio ALSA Switch Plugin failed to open the switcher target pcm volumioLocalPlayback Jul 18 14:34:37 srimusic mpd[2651]: alsa_output: Error opening default ALSA device: No such file or directory Jul 18 14:34:37 srimusic mpd[2651]: output: Successfully detected a jack audio device Jul 18 14:34:37 srimusic mpd[2651]: zeroconf: No global port, disabling zeroconf Jul 18 14:34:37 srimusic systemd[1]: Started Music Player Daemon. Jul 18 14:34:37 srimusic sudo[2598]: pam_unix(sudo:session): session closed for user root Jul 18 14:34:37 srimusic sudo[2635]: pam_unix(sudo:session): session closed for user root Jul 18 14:34:40 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:34:43 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:34:44 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:780:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer failed an mmap write to the the target pcm softvolume. 0 frames were written Jul 18 14:34:44 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:818:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer has not transferred a full period to the target pcm softvolume. 0 frames were written Jul 18 14:34:44 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: under-run Jul 18 14:34:44 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:34:47 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:34:48 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:34:49 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:780:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer failed an mmap write to the the target pcm softvolume. 0 frames were written Jul 18 14:34:49 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:818:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer has not transferred a full period to the target pcm softvolume. 0 frames were written Jul 18 14:34:49 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: under-run Jul 18 14:34:49 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:34:50 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:34:51 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:34:52 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:780:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer failed an mmap write to the the target pcm softvolume. 0 frames were written Jul 18 14:34:52 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:818:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer has not transferred a full period to the target pcm softvolume. 0 frames were written Jul 18 14:34:52 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: under-run Jul 18 14:34:52 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:34:52 srimusic volumio-remote-updater[666]: [2024-07-18 14:34:52] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Jul 18 14:34:53 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:34:54 srimusic shairport-sync[2663]: % Total % Received % Xferd Average Speed Time Time Time Current Jul 18 14:34:54 srimusic shairport-sync[2663]: Dload Upload Total Spent Left Speed Jul 18 14:34:54 srimusic shairport-sync[2663]: [213B blob data] Jul 18 14:34:54 srimusic shairport-sync[2663]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:143:(_snd_pcm_volumioswitch_open_target_pcm) PCM Volumio ALSA Switch Plugin failed to open the switcher target pcm volumioLocalPlayback Jul 18 14:34:54 srimusic shairport-sync[2663]: free(): double free detected in tcache 2 Jul 18 14:34:54 srimusic systemd[1]: shairport-sync.service: Main process exited, code=killed, status=6/ABRT Jul 18 14:34:54 srimusic systemd[1]: shairport-sync.service: Failed with result 'signal'. Jul 18 14:34:54 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:34:55 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:780:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer failed an mmap write to the the target pcm softvolume. 0 frames were written Jul 18 14:34:55 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:818:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer has not transferred a full period to the target pcm softvolume. 0 frames were written Jul 18 14:34:55 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: under-run Jul 18 14:34:55 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:34:57 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:34:57 srimusic volumio-remote-updater[666]: [2024-07-18 14:34:57] [connect] Successful connection Jul 18 14:34:58 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:34:59 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:780:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer failed an mmap write to the the target pcm softvolume. 0 frames were written Jul 18 14:34:59 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:818:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer has not transferred a full period to the target pcm softvolume. 0 frames were written Jul 18 14:34:59 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: under-run Jul 18 14:34:59 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:35:06 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:35:10 srimusic volumio-remote-updater[666]: [2024-07-18 14:35:10] [connect] Successful connection Jul 18 14:35:12 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:35:13 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:780:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer failed an mmap write to the the target pcm softvolume. 0 frames were written Jul 18 14:35:13 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:818:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer has not transferred a full period to the target pcm softvolume. 0 frames were written Jul 18 14:35:13 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: under-run Jul 18 14:35:13 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:35:14 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:35:15 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:35:16 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:780:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer failed an mmap write to the the target pcm softvolume. 0 frames were written Jul 18 14:35:16 srimusic audioinput[2217]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:818:(_snd_pcm_volumioswitch_transfer_wrap) PCM volumioMultiRoomServer has not transferred a full period to the target pcm softvolume. 0 frames were written Jul 18 14:35:16 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: under-run Jul 18 14:35:16 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:35:23 srimusic audioinput[2217]: /usr/bin/sox WARN alsa: over-run Jul 18 14:35:23 srimusic volumio[807]: No protocol specified Jul 18 14:35:23 srimusic volumio[807]: xcb_connection_has_error() returned true Jul 18 14:35:23 srimusic volumio[807]: Found hardware: "HDA-Intel" "Creative Sound Blaster Z" "HDA:11020011,11020023,00100918" "0x1102" "0x0010" Jul 18 14:35:23 srimusic volumio[807]: Hardware is initialized using a generic method Jul 18 14:35:23 srimusic volumio[807]: info: Output device has changed, restarting MPD Jul 18 14:35:23 srimusic sudo[2771]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 18 14:35:23 srimusic sudo[2771]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:35:23 srimusic volumio[807]: info: Output device has changed, restarting Shairport Sync Jul 18 14:35:23 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:35:23 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 18 14:35:23 srimusic sudo[2774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 18 14:35:23 srimusic sudo[2774]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:35:23 srimusic systemd[1]: Stopping Music Player Daemon... Jul 18 14:35:23 srimusic systemd[1]: mpd.service: Succeeded. Jul 18 14:35:23 srimusic systemd[1]: Stopped Music Player Daemon. Jul 18 14:35:23 srimusic volumio[807]: No protocol specified Jul 18 14:35:23 srimusic volumio[807]: xcb_connection_has_error() returned true Jul 18 14:35:23 srimusic volumio[807]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 18 14:35:23 srimusic volumio[807]: No protocol specified Jul 18 14:35:23 srimusic volumio[807]: xcb_connection_has_error() returned true Jul 18 14:35:23 srimusic volumio[807]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 18 14:35:23 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:35:23 srimusic systemd[1]: Starting Music Player Daemon... Jul 18 14:35:23 srimusic sudo[2783]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 18 14:35:23 srimusic sudo[2783]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:35:23 srimusic sudo[2783]: pam_unix(sudo:session): session closed for user root Jul 18 14:35:23 srimusic sudo[2787]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 18 14:35:23 srimusic sudo[2787]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:35:23 srimusic sudo[2787]: pam_unix(sudo:session): session closed for user root Jul 18 14:35:23 srimusic sudo[2779]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 18 14:35:23 srimusic sudo[2779]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:35:23 srimusic sudo[2779]: pam_unix(sudo:session): session closed for user root Jul 18 14:35:24 srimusic sudo[2771]: pam_unix(sudo:session): session closed for user root Jul 18 14:35:24 srimusic mpd[2792]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 18 14:35:24 srimusic mpd[2792]: output: No 'audio_output' defined in config file Jul 18 14:35:24 srimusic mpd[2792]: couldn't open play stream: Device or resource busy Jul 18 14:35:24 srimusic mpd[2792]: sndio_output: Error opening default sndio device Jul 18 14:35:24 srimusic mpd[2792]: ALSA lib /home/volumio-fifo-plugin/src/pcm_volumiofifo.c:753:(_snd_pcm_volumiofifo_open) Failed to open output fifo /tmp/fusiondspfifo Jul 18 14:35:24 srimusic mpd[2792]: ALSA lib /home/volumio-alsa-plugin/src/pcm_volumioswitch.c:143:(_snd_pcm_volumioswitch_open_target_pcm) PCM Volumio ALSA Switch Plugin failed to open the switcher target pcm volumioLocalPlayback Jul 18 14:35:24 srimusic mpd[2792]: alsa_output: Error opening default ALSA device: No such file or directory Jul 18 14:35:24 srimusic mpd[2792]: output: Successfully detected a jack audio device Jul 18 14:35:24 srimusic mpd[2792]: zeroconf: No global port, disabling zeroconf Jul 18 14:35:24 srimusic systemd[1]: Started Music Player Daemon. Jul 18 14:35:24 srimusic sudo[2774]: pam_unix(sudo:session): session closed for user root Jul 18 14:35:25 srimusic volumio-remote-updater[666]: [2024-07-18 14:35:25] [connect] Successful connection Jul 18 14:35:25 srimusic volumio[807]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Jul 18 14:35:25 srimusic volumio[807]: info: camilladsp service started and running in background, instance 1 Jul 18 14:35:25 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 18 14:35:26 srimusic volumio[807]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 18 14:35:26 srimusic volumio[807]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jul 18 14:35:26 srimusic volumio[807]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 18 14:35:26 srimusic volumio[807]: info: FusionDsp loaded Jul 18 14:35:26 srimusic volumio[807]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 18 14:35:26 srimusic sudo[2807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jul 18 14:35:26 srimusic sudo[2807]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 18 14:35:26 srimusic volumio[807]: info: FusionDsp - Reporting Fusion DSP Enabled Jul 18 14:35:26 srimusic volumio[807]: info: Adding Signal Path Element [object Object] Jul 18 14:35:26 srimusic volumio[807]: info: Adding fusiondspeq DSP Signal Path Element Jul 18 14:35:26 srimusic volumio[807]: info: FusionDsp - ---- installed callbackRead Jul 18 14:35:26 srimusic volumio[807]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 18 14:35:26 srimusic sudo[2807]: pam_unix(sudo:session): session closed for user root Jul 18 14:35:26 srimusic volumio[807]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jul 18 14:35:26 srimusic volumio[807]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Jul 18 14:35:26 srimusic volumio[807]: at onErrorNT (internal/child_process.js:472:16) Jul 18 14:35:26 srimusic volumio[807]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jul 18 14:35:26 srimusic volumio[807]: at runNextTicks (internal/process/task_queues.js:64:3) Jul 18 14:35:26 srimusic volumio[807]: at listOnTimeout (internal/timers.js:526:9) Jul 18 14:35:26 srimusic volumio[807]: at processTimers (internal/timers.js:500:7) { Jul 18 14:35:26 srimusic volumio[807]: errno: -2, Jul 18 14:35:26 srimusic volumio[807]: code: 'ENOENT', Jul 18 14:35:26 srimusic volumio[807]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jul 18 14:35:26 srimusic volumio[807]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jul 18 14:35:26 srimusic volumio[807]: spawnargs: [ Jul 18 14:35:26 srimusic volumio[807]: '-p', Jul 18 14:35:26 srimusic volumio[807]: 9876, Jul 18 14:35:26 srimusic volumio[807]: '-o', Jul 18 14:35:26 srimusic volumio[807]: '/tmp/camilladsp.log', Jul 18 14:35:26 srimusic volumio[807]: '-l', Jul 18 14:35:26 srimusic volumio[807]: 'warn', Jul 18 14:35:26 srimusic volumio[807]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jul 18 14:35:26 srimusic volumio[807]: ] Jul 18 14:35:26 srimusic volumio[807]: } Jul 18 14:35:26 srimusic volumio[807]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 18 14:35:26 srimusic sudo[2818]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-18 14:34 Jul 18 14:35:26 srimusic sudo[2818]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"