-- Logs begin at Fri 2024-10-04 14:49:20 EEST, end at Fri 2024-10-04 15:28:21 EEST. -- Oct 04 15:27:52 volumio-1 ntpd[569]: receive: Unexpected origin timestamp 0xeaaa5532.dd71171c does not match aorg 0000000000.00000000 from server@195.167.30.249 xmt 0xeaaa5dc8.a6e3c800 Oct 04 15:27:52 volumio-1 volumio[631]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Oct 04 15:27:52 volumio-1 volumio[631]: wlan0 Interface doesn't support scanning. Oct 04 15:27:52 volumio-1 volumio[631]: info: Cannot use regular scanning, forcing with ap-force Oct 04 15:27:53 volumio-1 sudo[803]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Oct 04 15:27:53 volumio-1 sudo[803]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 15:27:53 volumio-1 sudo[803]: pam_unix(sudo:session): session closed for user root Oct 04 15:27:53 volumio-1 volumio[631]: command failed: No such device (-19) Oct 04 15:27:53 volumio-1 volumio[631]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Oct 04 15:27:53 volumio-1 volumio[631]: command failed: No such device (-19) Oct 04 15:27:54 volumio-1 volumio[631]: Starting albumart workers Oct 04 15:27:55 volumio-1 volumio[631]: info: VolumeController:: Volume=86 Mute =false Oct 04 15:27:55 volumio-1 volumio[631]: info: CoreStateMachine::pushState Oct 04 15:27:55 volumio-1 volumio[631]: info: CorePlayQueue::getTrack 0 Oct 04 15:27:55 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 04 15:27:55 volumio-1 volumio[631]: info: CoreCommandRouter::volumioPushState Oct 04 15:27:55 volumio-1 volumio[631]: info: CoreStateMachine::updateTrackBlock Oct 04 15:27:55 volumio-1 volumio[631]: info: CorePlayQueue::getTrackBlock Oct 04 15:27:55 volumio-1 volumio[631]: info: CoreCommandRouter::volumioRetrievevolume Oct 04 15:27:56 volumio-1 volumio[631]: info: Setting Device type: Raspberry PI Oct 04 15:27:56 volumio-1 volumio[631]: info: CoreStateMachine::setRepeat null single undefined Oct 04 15:27:56 volumio-1 volumio[631]: info: CoreStateMachine::pushState Oct 04 15:27:56 volumio-1 volumio[631]: info: CorePlayQueue::getTrack 0 Oct 04 15:27:56 volumio-1 volumio[631]: info: CoreCommandRouter::volumioPushState Oct 04 15:27:56 volumio-1 volumio[631]: info: CoreStateMachine::setRandom null Oct 04 15:27:56 volumio-1 volumio[631]: info: CoreStateMachine::pushState Oct 04 15:27:56 volumio-1 volumio[631]: info: CorePlayQueue::getTrack 0 Oct 04 15:27:56 volumio-1 volumio[631]: info: CoreCommandRouter::volumioPushState Oct 04 15:27:57 volumio-1 sudo[817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Oct 04 15:27:57 volumio-1 sudo[817]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 15:27:57 volumio-1 volumio[631]: info: VolumeController:: Volume=86 Mute =false Oct 04 15:27:57 volumio-1 volumio[631]: info: CoreStateMachine::pushState Oct 04 15:27:57 volumio-1 volumio[631]: info: CorePlayQueue::getTrack 0 Oct 04 15:27:57 volumio-1 volumio[631]: info: CoreCommandRouter::volumioPushState Oct 04 15:27:57 volumio-1 volumio[631]: info: Discovery: adding 9f778565-da5a-4a5a-a8fc-333738792618 Oct 04 15:27:57 volumio-1 volumio[631]: info: Discovery: Found device Volumio 1 Oct 04 15:27:57 volumio-1 volumio[631]: info: CoreCommandRouter::volumioGetState Oct 04 15:27:57 volumio-1 volumio[631]: info: CorePlayQueue::getTrack 0 Oct 04 15:27:58 volumio-1 systemd[1]: Started UPnP Renderer front-end to MPD. Oct 04 15:27:58 volumio-1 sudo[817]: pam_unix(sudo:session): session closed for user root Oct 04 15:27:58 volumio-1 volumio-remote-updater[456]: [2024-10-04 15:27:58] [connect] Successful connection Oct 04 15:27:58 volumio-1 volumio[631]: info: Upmpdcli Daemon Started Oct 04 15:27:58 volumio-1 sudo[821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 04 15:27:59 volumio-1 volumio[631]: info: Completed loading Core Plugins Oct 04 15:27:59 volumio-1 sudo[821]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 15:27:59 volumio-1 volumio[631]: info: Preparing to generate the ALSA configuration file Oct 04 15:27:59 volumio-1 sudo[821]: pam_unix(sudo:session): session closed for user root Oct 04 15:27:59 volumio-1 sudo[823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 04 15:27:59 volumio-1 sudo[823]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 15:27:59 volumio-1 sudo[823]: pam_unix(sudo:session): session closed for user root Oct 04 15:27:59 volumio-1 volumio[631]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Oct 04 15:27:59 volumio-1 volumio[631]: info: Reading ALSA contributions from plugins. Oct 04 15:27:59 volumio-1 volumio[631]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 04 15:27:59 volumio-1 volumio-remote-updater[456]: [2024-10-04 15:27:59] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1728044878 101 Oct 04 15:28:00 volumio-1 volumio[631]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Oct 04 15:28:01 volumio-1 volumio[631]: verbose: New Socket.io Connection to 192.168.1.67 from 192.168.1.65 UA: Mozilla/5.0 (X11; Linux x86_64; rv:131.0) Gecko/20100101 Firefox/131.0 Engine version: 3 Transport: polling Total Clients: 2 Oct 04 15:28:02 volumio-1 volumio[631]: verbose: New Socket.io Connection to 192.168.1.67 from 192.168.1.65 UA: Mozilla/5.0 (X11; Linux x86_64; rv:131.0) Gecko/20100101 Firefox/131.0 Engine version: 3 Transport: polling Total Clients: 3 Oct 04 15:28:02 volumio-1 volumio[631]: error: Upnp client error: Error: connect ECONNREFUSED 127.0.0.1:6600 Oct 04 15:28:03 volumio-1 volumio[631]: info: Asound.conf file unchanged, so no further update is needed Oct 04 15:28:03 volumio-1 volumio[631]: info: Output device has changed, restarting MPD Oct 04 15:28:03 volumio-1 volumio[631]: info: Output device has changed, restarting Shairport Sync Oct 04 15:28:03 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 04 15:28:03 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 04 15:28:03 volumio-1 sudo[839]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 04 15:28:03 volumio-1 sudo[839]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 15:28:03 volumio-1 sudo[839]: pam_unix(sudo:session): session closed for user root Oct 04 15:28:03 volumio-1 sudo[841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 04 15:28:03 volumio-1 sudo[841]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 15:28:04 volumio-1 volumio[631]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 04 15:28:04 volumio-1 systemd[1]: Listening on mpd.socket. Oct 04 15:28:04 volumio-1 volumio[631]: info: ___________ START PLUGINS ___________ Oct 04 15:28:04 volumio-1 systemd[1]: Starting Music Player Daemon... Oct 04 15:28:04 volumio-1 volumio[631]: info: ControllerMpd::onStart: Initializing MPD Oct 04 15:28:04 volumio-1 volumio[631]: info: Creating MPD Configuration file Oct 04 15:28:04 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 04 15:28:04 volumio-1 volumio[631]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 04 15:28:04 volumio-1 volumio[631]: info: [1728044884944] CoreMusicLibrary::Adding element Media Servers Oct 04 15:28:04 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 04 15:28:05 volumio-1 sudo[850]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 04 15:28:05 volumio-1 sudo[850]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 15:28:05 volumio-1 sudo[850]: pam_unix(sudo:session): session closed for user root Oct 04 15:28:05 volumio-1 sudo[852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 04 15:28:05 volumio-1 sudo[852]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 15:28:05 volumio-1 sudo[848]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 04 15:28:05 volumio-1 sudo[848]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 15:28:05 volumio-1 sudo[848]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 04 15:28:05 volumio-1 sudo[848]: pam_unix(sudo:session): session closed for user root Oct 04 15:28:05 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 04 15:28:05 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 04 15:28:05 volumio-1 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 04 15:28:05 volumio-1 systemd[1]: mpd.service: Succeeded. Oct 04 15:28:05 volumio-1 systemd[1]: Stopped Music Player Daemon. Oct 04 15:28:05 volumio-1 systemd[1]: Starting Music Player Daemon... Oct 04 15:28:06 volumio-1 volumio[631]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 04 15:28:06 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 04 15:28:06 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 04 15:28:06 volumio-1 volumio[631]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 04 15:28:06 volumio-1 volumio[631]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 04 15:28:06 volumio-1 volumio[631]: info: [1728044886772] CoreMusicLibrary::Adding element Last_100 Oct 04 15:28:06 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 04 15:28:06 volumio-1 volumio[631]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 04 15:28:06 volumio-1 volumio[631]: info: [1728044886825] CoreMusicLibrary::Adding element Webradio Oct 04 15:28:06 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 04 15:28:06 volumio-1 sudo[858]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 04 15:28:06 volumio-1 sudo[858]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 15:28:06 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 04 15:28:06 volumio-1 sudo[858]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Oct 04 15:28:06 volumio-1 sudo[858]: pam_unix(sudo:session): session closed for user root Oct 04 15:28:07 volumio-1 volumio[631]: info: Initializing BBC Radios Oct 04 15:28:07 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 04 15:28:07 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 04 15:28:07 volumio-1 volumio[631]: info: Loading i18n strings for locale gr Oct 04 15:28:08 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 04 15:28:08 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 04 15:28:08 volumio-1 volumio[631]: info: FusionDsp - mixtype--------------------- Hardware Oct 04 15:28:08 volumio-1 volumio[631]: info: Volumio Calling Home Oct 04 15:28:09 volumio-1 volumio[631]: info: Preparing to generate the ALSA configuration file Oct 04 15:28:12 volumio-1 volumio[631]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Oct 04 15:28:12 volumio-1 volumio[631]: info: camilladsp service started and running in background, instance 1 Oct 04 15:28:12 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 04 15:28:12 volumio-1 volumio[631]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 04 15:28:12 volumio-1 volumio[631]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Oct 04 15:28:12 volumio-1 volumio[631]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 04 15:28:12 volumio-1 volumio[631]: info: FusionDsp loaded Oct 04 15:28:12 volumio-1 volumio[631]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 04 15:28:13 volumio-1 sudo[889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Oct 04 15:28:13 volumio-1 sudo[889]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 04 15:28:13 volumio-1 volumio[631]: info: FusionDsp - Reporting Fusion DSP Enabled Oct 04 15:28:13 volumio-1 volumio[631]: info: Adding Signal Path Element [object Object] Oct 04 15:28:13 volumio-1 volumio[631]: info: Adding fusiondspeq DSP Signal Path Element Oct 04 15:28:13 volumio-1 volumio[631]: info: FusionDsp - ---- installed callbackRead Oct 04 15:28:13 volumio-1 volumio[631]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 04 15:28:13 volumio-1 sudo[889]: pam_unix(sudo:session): session closed for user root Oct 04 15:28:13 volumio-1 volumio[631]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Oct 04 15:28:13 volumio-1 volumio[631]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Oct 04 15:28:13 volumio-1 volumio[631]: at onErrorNT (internal/child_process.js:465:16) Oct 04 15:28:13 volumio-1 volumio[631]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Oct 04 15:28:13 volumio-1 volumio[631]: at runNextTicks (internal/process/task_queues.js:62:3) Oct 04 15:28:13 volumio-1 volumio[631]: at listOnTimeout (internal/timers.js:523:9) Oct 04 15:28:13 volumio-1 volumio[631]: at processTimers (internal/timers.js:497:7) { Oct 04 15:28:13 volumio-1 volumio[631]: errno: -2, Oct 04 15:28:13 volumio-1 volumio[631]: code: 'ENOENT', Oct 04 15:28:13 volumio-1 volumio[631]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Oct 04 15:28:13 volumio-1 volumio[631]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Oct 04 15:28:13 volumio-1 volumio[631]: spawnargs: [ Oct 04 15:28:13 volumio-1 volumio[631]: '-p', Oct 04 15:28:13 volumio-1 volumio[631]: 9876, Oct 04 15:28:13 volumio-1 volumio[631]: '-o', Oct 04 15:28:13 volumio-1 volumio[631]: '/tmp/camilladsp.log', Oct 04 15:28:13 volumio-1 volumio[631]: '-l', Oct 04 15:28:13 volumio-1 volumio[631]: 'warn', Oct 04 15:28:13 volumio-1 volumio[631]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Oct 04 15:28:13 volumio-1 volumio[631]: ] Oct 04 15:28:13 volumio-1 volumio[631]: } Oct 04 15:28:13 volumio-1 volumio[631]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 04 15:28:21 volumio-1 sudo[900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-04 15:27 Oct 04 15:28:21 volumio-1 sudo[900]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"