-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Mon 2024-07-22 14:59:46 CEST. -- Jul 22 14:58:00 volumio systemd[1]: Reloading. Jul 22 14:58:00 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jul 22 14:58:00 volumio systemd[1]: Reloading. Jul 22 14:58:01 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jul 22 14:58:01 volumio systemd[1]: Reloading. Jul 22 14:58:01 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jul 22 14:58:02 volumio systemd[1]: Stopping MiniDLNA lightweight DLNA/UPnP-AV server... Jul 22 14:58:02 volumio volumio[962]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 14:58:02 volumio systemd[1]: minidlna.service: Succeeded. Jul 22 14:58:02 volumio systemd[1]: Stopped MiniDLNA lightweight DLNA/UPnP-AV server. Jul 22 14:58:02 volumio volumio[962]: info: Creating systemd unit /etc/systemd/system/minidlna.service Jul 22 14:58:02 volumio systemd[1]: Reloading. Jul 22 14:58:02 volumio systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Jul 22 14:58:02 volumio volumio[962]: info: Setting values for "network_interface" and "model_number" in /data/plugins/music_service/minidlna/config.json Jul 22 14:58:03 volumio volumio[962]: info: Setting permissions to MiniDLNA folders Jul 22 14:58:03 volumio sudo[2150]: pam_unix(sudo:session): session closed for user root Jul 22 14:58:03 volumio volumio[962]: info: Install script completed Jul 22 14:58:03 volumio volumio[962]: info: Adding reference to registry Jul 22 14:58:03 volumio volumio[962]: info: Done installing plugin. Jul 22 14:58:03 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 22 14:58:03 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 22 14:58:03 volumio volumio[962]: info: Folder /tmp/plugins removed Jul 22 14:58:03 volumio volumio[962]: info: Folder /tmp/downloaded_plugin.zip removed Jul 22 14:58:03 volumio volumio[962]: Plugin install end detected on script Jul 22 14:58:03 volumio volumio[962]: info: Folder /data/temp removed Jul 22 14:58:06 volumio volumio[962]: info: Enabling plugin minidlna Jul 22 14:58:06 volumio volumio[962]: info: Loading plugin "minidlna"... Jul 22 14:58:06 volumio volumio[962]: info: PLUGIN START: minidlna Jul 22 14:58:06 volumio volumio[962]: info: Loading i18n strings for locale it Jul 22 14:58:06 volumio volumio[962]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Jul 22 14:58:06 volumio volumio[962]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jul 22 14:58:06 volumio volumio[962]: info: minidlna: Found miniDLNA version 1.2.1 Jul 22 14:58:06 volumio volumio[962]: info: minidlna: /data/minidlna.conf written Jul 22 14:58:06 volumio volumio[962]: info: minidlna: Starting minidlna.service Jul 22 14:58:06 volumio sudo[2682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Jul 22 14:58:06 volumio sudo[2682]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 14:58:06 volumio systemd[1]: Started MiniDLNA lightweight DLNA/UPnP-AV server. Jul 22 14:58:06 volumio sudo[2682]: pam_unix(sudo:session): session closed for user root Jul 22 14:58:06 volumio volumio[962]: info: minidlna: systemctl start minidlna.service succeeded. Jul 22 14:58:06 volumio volumio[962]: info: Done. Jul 22 14:58:10 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Jul 22 14:58:10 volumio volumio[962]: info: CorePlayQueue::getTrack 5 Jul 22 14:58:16 volumio volumio[962]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 22 14:58:16 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jul 22 14:58:16 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 14:58:16 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jul 22 14:58:16 volumio volumio[962]: info: Getting Alsa Cards List without I2S DAC Jul 22 14:58:16 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Jul 22 14:58:16 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 14:58:16 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 14:58:16 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 14:58:16 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 14:58:16 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 14:58:16 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 14:58:16 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 14:58:16 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 22 14:58:16 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jul 22 14:58:16 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 22 14:58:19 volumio volumio[962]: info: CorePlayQueue::getTrack 5 Jul 22 14:58:19 volumio volumio[962]: info: CorePlayQueue::getTrack 6 Jul 22 14:58:19 volumio volumio[962]: info: Prefetching next song Jul 22 14:58:19 volumio volumio[962]: info: DOING PREFETCH IN MPD Jul 22 14:58:19 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand add "USB/Volume/HATIKWA/Live Mix by Godi Hatikwa 07 12 17.mp3" Jul 22 14:58:19 volumio volumio[962]: info: Jul 22 14:58:19 volumio volumio[962]: ---------------------------- MPD announces system playlist update Jul 22 14:58:19 volumio volumio[962]: info: Ignoring MPD Status Update Jul 22 14:58:19 volumio volumio[962]: info: sendMpdCommand add "USB/Volume/HATIKWA/Live Mix by Godi Hatikwa 07 12 17.mp3" took 3 milliseconds Jul 22 14:58:19 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand consume 1 Jul 22 14:58:19 volumio volumio[962]: info: Jul 22 14:58:19 volumio volumio[962]: ---------------------------- MPD announces state update: options Jul 22 14:58:19 volumio volumio[962]: info: ------------------------------ 4ms Jul 22 14:58:19 volumio volumio[962]: info: sendMpdCommand consume 1 took 1 milliseconds Jul 22 14:58:19 volumio volumio[962]: info: ControllerMpd::getState Jul 22 14:58:19 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand status Jul 22 14:58:19 volumio volumio[962]: info: sendMpdCommand status took 1 milliseconds Jul 22 14:58:19 volumio volumio[962]: verbose: ControllerMpd::parseState Jul 22 14:58:19 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 22 14:58:19 volumio volumio[962]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 22 14:58:19 volumio volumio[962]: verbose: ControllerMpd::parseTrackInfo Jul 22 14:58:19 volumio volumio[962]: info: ControllerMpd::pushState Jul 22 14:58:19 volumio volumio[962]: info: CoreCommandRouter::servicePushState Jul 22 14:58:19 volumio volumio[962]: info: CorePlayQueue::getTrack 5 Jul 22 14:58:19 volumio volumio[962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":197588,"duration":202,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Kungs - Clap Your Hands (Clip Officiel).mp3","artist":null,"album":null,"uri":"USB/Volume/HATIKWA/Kungs - Clap Your Hands (Clip Officiel).mp3","trackType":"mp3"} Jul 22 14:58:19 volumio volumio[962]: verbose: CURRENT POSITION 5 Jul 22 14:58:19 volumio volumio[962]: info: CoreStateMachine::syncState stateService play Jul 22 14:58:19 volumio volumio[962]: info: CoreStateMachine::syncState currentStatus play Jul 22 14:58:19 volumio volumio[962]: info: Received an update from plugin. extracting info from payload Jul 22 14:58:19 volumio volumio[962]: info: CoreStateMachine::pushState Jul 22 14:58:19 volumio volumio[962]: info: CorePlayQueue::getTrack 5 Jul 22 14:58:19 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 14:58:19 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Jul 22 14:58:19 volumio volumio[962]: info: MRS: Pushing multiroomSync output update for this device Jul 22 14:58:19 volumio volumio[962]: info: MRS: Pushing multiroomSync output Jul 22 14:58:19 volumio volumio[962]: info: CoreStateMachine::pushState Jul 22 14:58:19 volumio volumio[962]: info: CorePlayQueue::getTrack 5 Jul 22 14:58:19 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Jul 22 14:58:19 volumio volumio[962]: info: MRS: Pushing multiroomSync output update for this device Jul 22 14:58:19 volumio volumio[962]: info: MRS: Pushing multiroomSync output Jul 22 14:58:19 volumio volumio[962]: info: ------------------------------ 24ms Jul 22 14:58:19 volumio volumio[962]: info: CoreCommandRouter::volumioGetState Jul 22 14:58:19 volumio volumio[962]: info: CorePlayQueue::getTrack 5 Jul 22 14:58:21 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 22 14:58:21 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 22 14:58:23 volumio volumio[962]: info: CoreStateMachine::startPlaybackTimer Jul 22 14:58:23 volumio volumio[962]: info: CorePlayQueue::getTrack 6 Jul 22 14:58:23 volumio volumio[962]: info: Jul 22 14:58:23 volumio volumio[962]: ---------------------------- MPD announces system playlist update Jul 22 14:58:23 volumio volumio[962]: info: Ignoring MPD Status Update Jul 22 14:58:23 volumio volumio[962]: info: Jul 22 14:58:23 volumio volumio[962]: ---------------------------- MPD announces state update: player Jul 22 14:58:23 volumio volumio[962]: info: ControllerMpd::getState Jul 22 14:58:23 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand status Jul 22 14:58:23 volumio volumio[962]: info: ------------------------------ 2ms Jul 22 14:58:23 volumio volumio[962]: info: sendMpdCommand status took 1 milliseconds Jul 22 14:58:23 volumio volumio[962]: verbose: ControllerMpd::parseState Jul 22 14:58:23 volumio volumio[962]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 22 14:58:23 volumio volumio[962]: info: sendMpdCommand playlistinfo took 1 milliseconds Jul 22 14:58:23 volumio volumio[962]: verbose: ControllerMpd::parseTrackInfo Jul 22 14:58:23 volumio volumio[962]: info: ControllerMpd::pushState Jul 22 14:58:23 volumio volumio[962]: info: CoreCommandRouter::servicePushState Jul 22 14:58:23 volumio volumio[962]: info: CorePlayQueue::getTrack 6 Jul 22 14:58:23 volumio volumio[962]: verbose: STATE SERVICE {"status":"play","position":0,"seek":102,"duration":6859,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Live Mix by Godi Hatikwa 07 12 17.mp3","artist":null,"album":null,"uri":"USB/Volume/HATIKWA/Live Mix by Godi Hatikwa 07 12 17.mp3","trackType":"mp3"} Jul 22 14:58:23 volumio volumio[962]: verbose: CURRENT POSITION 6 Jul 22 14:58:23 volumio volumio[962]: info: CoreStateMachine::syncState stateService play Jul 22 14:58:23 volumio volumio[962]: info: CoreStateMachine::syncState currentStatus play Jul 22 14:58:23 volumio volumio[962]: info: Received an update from plugin. extracting info from payload Jul 22 14:58:23 volumio volumio[962]: info: CoreStateMachine::pushState Jul 22 14:58:23 volumio volumio[962]: info: CorePlayQueue::getTrack 6 Jul 22 14:58:23 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 14:58:23 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Jul 22 14:58:23 volumio volumio[962]: info: MRS: Pushing multiroomSync output update for this device Jul 22 14:58:23 volumio volumio[962]: info: MRS: Pushing multiroomSync output Jul 22 14:58:23 volumio volumio[962]: info: CoreStateMachine::pushState Jul 22 14:58:23 volumio volumio[962]: info: CorePlayQueue::getTrack 6 Jul 22 14:58:23 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Jul 22 14:58:23 volumio volumio[962]: info: MRS: Pushing multiroomSync output update for this device Jul 22 14:58:23 volumio volumio[962]: info: MRS: Pushing multiroomSync output Jul 22 14:58:23 volumio volumio[962]: info: ------------------------------ 29ms Jul 22 14:58:24 volumio volumio[962]: info: CoreStateMachine::pushState Jul 22 14:58:24 volumio volumio[962]: info: CorePlayQueue::getTrack 6 Jul 22 14:58:24 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 22 14:58:24 volumio volumio[962]: info: CoreCommandRouter::volumioPushState Jul 22 14:58:24 volumio volumio[962]: info: MRS: Pushing multiroomSync output update for this device Jul 22 14:58:24 volumio volumio[962]: info: MRS: Pushing multiroomSync output Jul 22 14:58:48 volumio wpa_supplicant[873]: RRM: Ignoring radio measurement request: Not RRM network Jul 22 14:58:48 volumio ntpd[779]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Jul 22 14:58:50 volumio wpa_supplicant[873]: RRM: Ignoring radio measurement request: Not RRM network Jul 22 14:59:42 volumio volumio[962]: info: Enabling plugin fusiondsp Jul 22 14:59:42 volumio volumio[962]: info: Loading plugin "fusiondsp"... Jul 22 14:59:42 volumio volumio[962]: info: Preparing to generate the ALSA configuration file Jul 22 14:59:42 volumio volumio[962]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 22 14:59:42 volumio volumio[962]: info: Reading ALSA contributions from plugins. Jul 22 14:59:42 volumio volumio[962]: info: Asound.conf file unchanged, so no further update is needed Jul 22 14:59:42 volumio volumio[962]: info: Output device has changed, restarting MPD Jul 22 14:59:43 volumio sudo[2824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 22 14:59:43 volumio sudo[2824]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 14:59:43 volumio sudo[2824]: pam_unix(sudo:session): session closed for user root Jul 22 14:59:43 volumio volumio[962]: info: Output device has changed, restarting Shairport Sync Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 14:59:43 volumio sudo[2829]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 22 14:59:43 volumio sudo[2829]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 14:59:43 volumio systemd[1]: Stopping Music Player Daemon... Jul 22 14:59:43 volumio volumio[962]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 22 14:59:43 volumio volumio[962]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio systemd[1]: mpd.service: Succeeded. Jul 22 14:59:43 volumio systemd[1]: Stopped Music Player Daemon. Jul 22 14:59:43 volumio vtcs[1625]: [2024-07-22 14:59:43.095] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Jul 22 14:59:43 volumio vtcs[1625]: [2024-07-22 14:59:43.096] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=8 errorno=104 error=Connection reset by peer Jul 22 14:59:43 volumio vtcs[1625]: [2024-07-22 14:59:43.096] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Jul 22 14:59:43 volumio systemd[1]: Starting Music Player Daemon... Jul 22 14:59:43 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Jul 22 14:59:43 volumio volumio[962]: info: PLUGIN START: fusiondsp Jul 22 14:59:43 volumio volumio[962]: info: Loading i18n strings for locale it Jul 22 14:59:43 volumio sudo[2838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 22 14:59:43 volumio sudo[2838]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 14:59:43 volumio volumio[962]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Jul 22 14:59:43 volumio volumio[962]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: FusionDsp - mixtype--------------------- Hardware Jul 22 14:59:43 volumio volumio[962]: info: Preparing to generate the ALSA configuration file Jul 22 14:59:43 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Jul 22 14:59:43 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jul 22 14:59:43 volumio systemd[1]: vtcs.service: Succeeded. Jul 22 14:59:43 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jul 22 14:59:43 volumio volumio[962]: info: Done. Jul 22 14:59:43 volumio sudo[2838]: pam_unix(sudo:session): session closed for user root Jul 22 14:59:43 volumio volumio[962]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 22 14:59:43 volumio volumio[962]: info: Reading ALSA contributions from plugins. Jul 22 14:59:43 volumio sudo[2834]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 22 14:59:43 volumio sudo[2834]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 14:59:43 volumio volumio[962]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 14:59:43 volumio volumio[962]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 14:59:43 volumio sudo[2834]: pam_unix(sudo:session): session closed for user root Jul 22 14:59:43 volumio volumio[962]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 14:59:43 volumio volumio[962]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 14:59:43 volumio sudo[2842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 22 14:59:43 volumio sudo[2842]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 14:59:43 volumio volumio[962]: info: MPD Permissions set Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio sudo[2842]: pam_unix(sudo:session): session closed for user root Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: Starting Shairport Sync Jul 22 14:59:43 volumio volumio[962]: info: Asound.conf file unchanged, so no further update is needed Jul 22 14:59:43 volumio volumio[962]: info: Output device has changed, restarting MPD Jul 22 14:59:43 volumio sudo[2852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 22 14:59:43 volumio sudo[2852]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 14:59:43 volumio volumio[962]: info: Output device has changed, restarting Shairport Sync Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 14:59:43 volumio sudo[2855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 22 14:59:43 volumio sudo[2855]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 14:59:43 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 22 14:59:43 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 22 14:59:43 volumio sudo[2855]: pam_unix(sudo:session): session closed for user root Jul 22 14:59:43 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 22 14:59:43 volumio sudo[2857]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 22 14:59:43 volumio sudo[2857]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 14:59:43 volumio volumio[962]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 22 14:59:43 volumio volumio[962]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 22 14:59:43 volumio sudo[2852]: pam_unix(sudo:session): session closed for user root Jul 22 14:59:43 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 22 14:59:43 volumio systemd[1]: mpd.service: Succeeded. Jul 22 14:59:43 volumio systemd[1]: Stopped Music Player Daemon. Jul 22 14:59:43 volumio systemd[1]: Starting Music Player Daemon... Jul 22 14:59:43 volumio kernel: pcm512x 1-004d: No SCLK, using BCLK: -2 Jul 22 14:59:43 volumio sudo[2874]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 22 14:59:43 volumio volumio[962]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 14:59:43 volumio volumio[962]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 14:59:43 volumio sudo[2874]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 14:59:43 volumio volumio[962]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 14:59:43 volumio volumio[962]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 14:59:43 volumio volumio[962]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 14:59:43 volumio volumio[962]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 14:59:43 volumio volumio[962]: info: MPD Permissions set Jul 22 14:59:43 volumio volumio[962]: info: Shairport-Sync Started Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio sudo[2876]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 22 14:59:43 volumio sudo[2876]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 14:59:43 volumio sudo[2874]: pam_unix(sudo:session): session closed for user root Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:43 volumio volumio[962]: info: Starting Shairport Sync Jul 22 14:59:43 volumio sudo[2873]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 22 14:59:43 volumio sudo[2873]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 14:59:43 volumio sudo[2876]: pam_unix(sudo:session): session closed for user root Jul 22 14:59:43 volumio sudo[2873]: pam_unix(sudo:session): session closed for user root Jul 22 14:59:43 volumio sudo[2888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 22 14:59:43 volumio sudo[2888]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 14:59:43 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 22 14:59:43 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 22 14:59:43 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 22 14:59:43 volumio volumio[962]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 22 14:59:43 volumio volumio[962]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 22 14:59:43 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 22 14:59:43 volumio sudo[2888]: pam_unix(sudo:session): session closed for user root Jul 22 14:59:43 volumio volumio[962]: info: Shairport-Sync Started Jul 22 14:59:45 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 22 14:59:45 volumio volumio[962]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Jul 22 14:59:45 volumio volumio[962]: info: camilladsp service started and running in background, instance 1 Jul 22 14:59:45 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 22 14:59:45 volumio mpd[2887]: Jul 22 14:59 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 22 14:59:45 volumio systemd[1]: Started Music Player Daemon. Jul 22 14:59:45 volumio sudo[2829]: pam_unix(sudo:session): session closed for user root Jul 22 14:59:45 volumio sudo[2857]: pam_unix(sudo:session): session closed for user root Jul 22 14:59:45 volumio volumio[962]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 22 14:59:45 volumio volumio[962]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jul 22 14:59:45 volumio volumio[962]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 22 14:59:45 volumio volumio[962]: info: FusionDsp loaded Jul 22 14:59:45 volumio volumio[962]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 22 14:59:45 volumio sudo[2906]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jul 22 14:59:45 volumio sudo[2906]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 22 14:59:45 volumio volumio[962]: info: FusionDsp - Reporting Fusion DSP Enabled Jul 22 14:59:45 volumio volumio[962]: info: Adding Signal Path Element [object Object] Jul 22 14:59:45 volumio volumio[962]: info: Adding fusiondspeq DSP Signal Path Element Jul 22 14:59:45 volumio volumio[962]: info: FusionDsp - ---- installed callbackRead Jul 22 14:59:45 volumio volumio[962]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 14:59:45 volumio sudo[2906]: pam_unix(sudo:session): session closed for user root Jul 22 14:59:45 volumio volumio[962]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jul 22 14:59:45 volumio volumio[962]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jul 22 14:59:45 volumio volumio[962]: at onErrorNT (internal/child_process.js:465:16) Jul 22 14:59:45 volumio volumio[962]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Jul 22 14:59:45 volumio volumio[962]: errno: -2, Jul 22 14:59:45 volumio volumio[962]: code: 'ENOENT', Jul 22 14:59:45 volumio volumio[962]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jul 22 14:59:45 volumio volumio[962]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jul 22 14:59:45 volumio volumio[962]: spawnargs: [ Jul 22 14:59:45 volumio volumio[962]: '-p', Jul 22 14:59:45 volumio volumio[962]: 9876, Jul 22 14:59:45 volumio volumio[962]: '-o', Jul 22 14:59:45 volumio volumio[962]: '/tmp/camilladsp.log', Jul 22 14:59:45 volumio volumio[962]: '-l', Jul 22 14:59:45 volumio volumio[962]: 'warn', Jul 22 14:59:45 volumio volumio[962]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jul 22 14:59:45 volumio volumio[962]: ] Jul 22 14:59:45 volumio volumio[962]: } Jul 22 14:59:45 volumio volumio[962]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 22 14:59:46 volumio sudo[2917]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-22 14:58 Jul 22 14:59:46 volumio sudo[2917]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"