-- Logs begin at Sun 2024-07-07 16:21:53 UTC, end at Sun 2024-07-07 17:28:34 UTC. -- Jul 07 17:28:19 volumio ntpd[524]: receive: Unexpected origin timestamp 0xea353f9d.986adf16 does not match aorg 0000000000.00000000 from server@217.115.11.162 xmt 0xea354eb3.bb6c3ef7 Jul 07 17:28:19 volumio ntpd[524]: receive: Unexpected origin timestamp 0xea353f9d.9862fca2 does not match aorg 0000000000.00000000 from server@161.97.164.152 xmt 0xea354eb3.bbc47004 Jul 07 17:28:19 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 07 17:28:19 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 07 17:28:19 volumio volumio[690]: info: Discovery: Getting this device information Jul 07 17:28:19 volumio volumio[690]: info: CoreCommandRouter::volumioGetState Jul 07 17:28:19 volumio volumio[690]: info: CorePlayQueue::getTrack 0 Jul 07 17:28:19 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 17:28:20 volumio volumio[690]: info: MPD running with PID750 Jul 07 17:28:20 volumio volumio[690]: ,establishing connection Jul 07 17:28:20 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 17:28:20 volumio volumio[690]: Starting albumart workers Jul 07 17:28:20 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 17:28:20 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 17:28:20 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 17:28:20 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 17:28:20 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 17:28:20 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 17:28:20 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 17:28:20 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 17:28:20 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 17:28:20 volumio volumio[690]: info: Reloading queue from file Jul 07 17:28:20 volumio volumio[690]: error: updateQueue error: null Jul 07 17:28:20 volumio volumio[690]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jul 07 17:28:20 volumio volumio[690]: info: CoreStateMachine::setRepeat true single undefined Jul 07 17:28:20 volumio volumio[690]: info: CoreStateMachine::pushState Jul 07 17:28:20 volumio volumio[690]: info: CorePlayQueue::getTrack 0 Jul 07 17:28:20 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 07 17:28:20 volumio volumio[690]: info: CoreCommandRouter::volumioPushState Jul 07 17:28:21 volumio volumio[690]: info: CoreStateMachine::setRandom undefined Jul 07 17:28:21 volumio volumio[690]: info: CoreStateMachine::pushState Jul 07 17:28:21 volumio volumio[690]: info: CorePlayQueue::getTrack 0 Jul 07 17:28:21 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 07 17:28:21 volumio volumio[690]: info: CoreCommandRouter::volumioPushState Jul 07 17:28:21 volumio volumio[690]: info: Setting Device type: Raspberry PI Jul 07 17:28:21 volumio volumio[690]: info: Completed loading Core Plugins Jul 07 17:28:21 volumio volumio[690]: info: Preparing to generate the ALSA configuration file Jul 07 17:28:21 volumio volumio[690]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 07 17:28:21 volumio volumio[690]: info: Reading ALSA contributions from plugins. Jul 07 17:28:21 volumio volumio[690]: error: updateQueue error: null Jul 07 17:28:21 volumio volumio[690]: info: VolumeController:: Volume=16 Mute =false Jul 07 17:28:21 volumio volumio[690]: info: CoreStateMachine::pushState Jul 07 17:28:21 volumio volumio[690]: info: CorePlayQueue::getTrack 0 Jul 07 17:28:21 volumio volumio[690]: info: CoreCommandRouter::volumioPushState Jul 07 17:28:21 volumio volumio[690]: info: Discovery: adding d16252be-7d05-490a-91f8-bb04ddf04f81 Jul 07 17:28:21 volumio volumio[690]: info: Discovery: Found device Volumio Jul 07 17:28:21 volumio volumio[690]: info: CoreCommandRouter::volumioGetState Jul 07 17:28:21 volumio volumio[690]: info: CorePlayQueue::getTrack 0 Jul 07 17:28:21 volumio sudo[800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jul 07 17:28:21 volumio sudo[800]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 17:28:21 volumio volumio[690]: info: Asound.conf file unchanged, so no further update is needed Jul 07 17:28:21 volumio volumio[690]: info: Output device has changed, restarting MPD Jul 07 17:28:22 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jul 07 17:28:22 volumio sudo[800]: pam_unix(sudo:session): session closed for user root Jul 07 17:28:22 volumio volumio[690]: info: Output device has changed, restarting Shairport Sync Jul 07 17:28:22 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 17:28:22 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 17:28:22 volumio sudo[805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 07 17:28:22 volumio sudo[805]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 17:28:22 volumio sudo[805]: pam_unix(sudo:session): session closed for user root Jul 07 17:28:22 volumio sudo[807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 07 17:28:22 volumio sudo[807]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 17:28:22 volumio systemd[1]: Stopping Music Player Daemon... Jul 07 17:28:22 volumio systemd[1]: mpd.service: Succeeded. Jul 07 17:28:22 volumio systemd[1]: Stopped Music Player Daemon. Jul 07 17:28:22 volumio systemd[1]: Starting Music Player Daemon... Jul 07 17:28:23 volumio volumio[690]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 07 17:28:23 volumio volumio[690]: info: ___________ START PLUGINS ___________ Jul 07 17:28:23 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 07 17:28:23 volumio volumio[690]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 17:28:23 volumio volumio[690]: info: [1720373303228] CoreMusicLibrary::Adding element Media Servers Jul 07 17:28:23 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 17:28:23 volumio volumio[690]: Cannot find translation for sourceMedia Servers Jul 07 17:28:23 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 17:28:23 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 17:28:24 volumio volumio[690]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 07 17:28:24 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 17:28:24 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 07 17:28:24 volumio volumio[690]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 07 17:28:24 volumio volumio[690]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 17:28:24 volumio volumio[690]: info: [1720373304881] CoreMusicLibrary::Adding element Last_100 Jul 07 17:28:24 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 17:28:24 volumio volumio[690]: Cannot find translation for sourceMedia Servers Jul 07 17:28:24 volumio volumio[690]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jul 07 17:28:24 volumio volumio[690]: info: [1720373304947] CoreMusicLibrary::Adding element Webradio Jul 07 17:28:24 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 07 17:28:25 volumio volumio[690]: Cannot find translation for sourceMedia Servers Jul 07 17:28:25 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jul 07 17:28:25 volumio volumio[690]: info: Loading i18n strings for locale en Jul 07 17:28:25 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 07 17:28:25 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 17:28:25 volumio volumio[690]: info: FusionDsp - mixtype--------------------- Hardware Jul 07 17:28:25 volumio volumio[690]: info: Volumio Calling Home Jul 07 17:28:27 volumio volumio[690]: info: Preparing to generate the ALSA configuration file Jul 07 17:28:27 volumio volumio[690]: info: Completed starting Core Plugins Jul 07 17:28:27 volumio volumio[690]: info: ------------------------------------------- Jul 07 17:28:27 volumio volumio[690]: info: ----- MyVolumio plugins startup ---- Jul 07 17:28:27 volumio volumio[690]: info: ------------------------------------------- Jul 07 17:28:27 volumio volumio[690]: info: [MyVolumio PluginManager] Fetching plans data.... Jul 07 17:28:28 volumio volumio-remote-updater[336]: [2024-07-07 17:28:28] [connect] Successful connection Jul 07 17:28:29 volumio volumio[690]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Jul 07 17:28:29 volumio volumio[690]: info: camilladsp service started and running in background, instance 1 Jul 07 17:28:29 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 07 17:28:29 volumio volumio[690]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 07 17:28:29 volumio volumio[690]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jul 07 17:28:29 volumio volumio[690]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 07 17:28:29 volumio volumio[690]: info: FusionDsp loaded Jul 07 17:28:29 volumio volumio[690]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 07 17:28:29 volumio sudo[843]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jul 07 17:28:30 volumio sudo[843]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 07 17:28:30 volumio sudo[843]: pam_unix(sudo:session): session closed for user root Jul 07 17:28:30 volumio volumio[690]: info: FusionDsp - Reporting Fusion DSP Enabled Jul 07 17:28:30 volumio volumio[690]: info: FusionDsp - ---- installed callbackRead Jul 07 17:28:30 volumio volumio[690]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 17:28:30 volumio volumio[690]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jul 07 17:28:30 volumio volumio[690]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jul 07 17:28:30 volumio volumio[690]: at onErrorNT (internal/child_process.js:465:16) Jul 07 17:28:30 volumio volumio[690]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jul 07 17:28:30 volumio volumio[690]: at runNextTicks (internal/process/task_queues.js:62:3) Jul 07 17:28:30 volumio volumio[690]: at listOnTimeout (internal/timers.js:523:9) Jul 07 17:28:30 volumio volumio[690]: at processTimers (internal/timers.js:497:7) { Jul 07 17:28:30 volumio volumio[690]: errno: -2, Jul 07 17:28:30 volumio volumio[690]: code: 'ENOENT', Jul 07 17:28:30 volumio volumio[690]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jul 07 17:28:30 volumio volumio[690]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jul 07 17:28:30 volumio volumio[690]: spawnargs: [ Jul 07 17:28:30 volumio volumio[690]: '-p', Jul 07 17:28:30 volumio volumio[690]: 9876, Jul 07 17:28:30 volumio volumio[690]: '-o', Jul 07 17:28:30 volumio volumio[690]: '/tmp/camilladsp.log', Jul 07 17:28:30 volumio volumio[690]: '-l', Jul 07 17:28:30 volumio volumio[690]: 'warn', Jul 07 17:28:30 volumio volumio[690]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jul 07 17:28:30 volumio volumio[690]: ] Jul 07 17:28:30 volumio volumio[690]: } Jul 07 17:28:30 volumio volumio[690]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 07 17:28:33 volumio mpd[818]: Jul 07 17:28 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 07 17:28:33 volumio mpd[818]: Jul 07 17:28 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Jul 07 17:28:33 volumio mpd[818]: Jul 07 17:28 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Jul 07 17:28:33 volumio systemd[1]: Started Music Player Daemon. Jul 07 17:28:33 volumio sudo[807]: pam_unix(sudo:session): session closed for user root Jul 07 17:28:34 volumio sudo[856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-07 17:27 Jul 07 17:28:34 volumio sudo[856]: 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"