-- Logs begin at Thu 2019-02-14 19:11:59 JST, end at Sun 2025-02-23 23:51:03 JST. -- Feb 23 23:50:01 volumio volumio[979]: info: BOOT COMPLETED Feb 23 23:50:02 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 23:50:05 volumio ntpd[796]: Soliciting pool server 133.130.121.141 Feb 23 23:50:05 volumio ntpd[796]: Soliciting pool server 167.179.119.205 Feb 23 23:50:06 volumio ntpd[796]: Soliciting pool server 162.159.200.123 Feb 23 23:50:06 volumio ntpd[796]: Soliciting pool server 162.159.200.1 Feb 23 23:50:06 volumio ntpd[796]: Soliciting pool server 129.250.35.251 Feb 23 23:50:06 volumio volumio[979]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 23 23:50:07 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 23 23:50:07 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:50:07 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 23 23:50:07 volumio volumio[979]: info: Getting Alsa Cards List without I2S DAC Feb 23 23:50:07 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Feb 23 23:50:07 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:50:07 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 23:50:07 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 23:50:07 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 23:50:07 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 23:50:07 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 23:50:07 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 23:50:07 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 23 23:50:07 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 23 23:50:07 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 23 23:50:07 volumio ntpd[796]: Soliciting pool server 160.16.113.133 Feb 23 23:50:07 volumio ntpd[796]: Soliciting pool server 129.250.35.250 Feb 23 23:50:07 volumio ntpd[796]: Soliciting pool server 202.182.111.234 Feb 23 23:50:08 volumio ntpd[796]: Soliciting pool server 133.243.238.243 Feb 23 23:50:08 volumio ntpd[796]: Soliciting pool server 133.243.238.163 Feb 23 23:50:08 volumio ntpd[796]: Soliciting pool server 45.159.48.231 Feb 23 23:50:09 volumio ntpd[796]: Soliciting pool server 23.81.40.154 Feb 23 23:50:09 volumio ntpd[796]: Soliciting pool server 18.181.48.156 Feb 23 23:50:09 volumio ntpd[796]: Soliciting pool server 122.215.240.52 Feb 23 23:50:10 volumio volumio[979]: error: error Feb 23 23:50:10 volumio ntpd[796]: Soliciting pool server 45.77.20.103 Feb 23 23:50:11 volumio ntpd[796]: Soliciting pool server 2401:c080:1000:48b4:5400:4ff:fe9d:d455 Feb 23 23:50:16 volumio ntpd[796]: receive: Unexpected origin timestamp 0xeb65b427.6bdf353a does not match aorg 0000000000.00000000 from server@18.181.48.156 xmt 0xeb65b428.3e550b36 Feb 23 23:50:16 volumio ntpd[796]: receive: Unexpected origin timestamp 0xeb65b427.6be3ef6f does not match aorg 0000000000.00000000 from server@129.250.35.251 xmt 0xeb65b428.3d1f0f7a Feb 23 23:50:16 volumio ntpd[796]: receive: Unexpected origin timestamp 0xeb65b427.6bdbce3d does not match aorg 0000000000.00000000 from server@45.77.20.103 xmt 0xeb65b428.3e6e20f2 Feb 23 23:50:16 volumio ntpd[796]: receive: Unexpected origin timestamp 0xeb65b427.6be07e2a does not match aorg 0000000000.00000000 from server@45.159.48.231 xmt 0xeb65b428.3ef0ecde Feb 23 23:50:16 volumio ntpd[796]: receive: Unexpected origin timestamp 0xeb65b427.6be2d158 does not match aorg 0000000000.00000000 from server@160.16.113.133 xmt 0xeb65b428.3eb106a8 Feb 23 23:50:16 volumio ntpd[796]: receive: Unexpected origin timestamp 0xeb65b427.6be1aa50 does not match aorg 0000000000.00000000 from server@133.243.238.243 xmt 0xeb65b428.3ecbb76f Feb 23 23:50:16 volumio ntpd[796]: Soliciting pool server 108.160.132.224 Feb 23 23:50:17 volumio ntpd[796]: Soliciting pool server 202.181.103.212 Feb 23 23:50:53 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 23 23:50:53 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Feb 23 23:50:59 volumio volumio[979]: info: Enabling plugin fusiondsp Feb 23 23:50:59 volumio volumio[979]: info: Loading plugin "fusiondsp"... Feb 23 23:51:00 volumio volumio[979]: info: Preparing to generate the ALSA configuration file Feb 23 23:51:00 volumio volumio[979]: info: Asound.conf file unchanged, so no further update is needed Feb 23 23:51:00 volumio volumio[979]: info: Output device has changed, restarting MPD Feb 23 23:51:00 volumio volumio[979]: info: Output device has changed, restarting Shairport Sync Feb 23 23:51:00 volumio sudo[1615]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:51:00 volumio sudo[1615]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:51:00 volumio sudo[1615]: pam_unix(sudo:session): session closed for user root Feb 23 23:51:00 volumio sudo[1617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 23:51:00 volumio sudo[1617]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:51:00 volumio systemd[1]: Stopping Music Player Daemon... Feb 23 23:51:00 volumio volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 23:51:00 volumio volumio[979]: info: PLUGIN START: fusiondsp Feb 23 23:51:00 volumio systemd[1]: mpd.service: Succeeded. Feb 23 23:51:00 volumio systemd[1]: Stopped Music Player Daemon. Feb 23 23:51:00 volumio volumio[979]: info: Loading i18n strings for locale ja Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:51:00 volumio volumio[979]: info: FusionDsp - mixtype--------------------- Hardware Feb 23 23:51:00 volumio volumio[979]: info: Preparing to generate the ALSA configuration file Feb 23 23:51:00 volumio volumio[979]: info: Done. Feb 23 23:51:00 volumio volumio[979]: info: MPD Permissions set Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:51:00 volumio volumio[979]: info: Asound.conf file unchanged, so no further update is needed Feb 23 23:51:00 volumio volumio[979]: info: Output device has changed, restarting MPD Feb 23 23:51:00 volumio systemd[1]: Starting Music Player Daemon... Feb 23 23:51:00 volumio volumio[979]: info: Output device has changed, restarting Shairport Sync Feb 23 23:51:00 volumio sudo[1629]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:51:00 volumio sudo[1629]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:51:00 volumio sudo[1629]: pam_unix(sudo:session): session closed for user root Feb 23 23:51:00 volumio sudo[1631]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 23 23:51:00 volumio sudo[1631]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:51:00 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 23 23:51:00 volumio systemd[1]: mpd.service: Succeeded. Feb 23 23:51:00 volumio systemd[1]: Stopped Music Player Daemon. Feb 23 23:51:00 volumio volumio[979]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 23 23:51:00 volumio systemd[1]: Starting Music Player Daemon... Feb 23 23:51:00 volumio volumio[979]: info: MPD Permissions set Feb 23 23:51:00 volumio volumio[979]: info: Starting Shairport Sync Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:51:00 volumio sudo[1639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 23:51:00 volumio sudo[1639]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 23 23:51:00 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:51:00 volumio volumio[979]: info: Starting Shairport Sync Feb 23 23:51:00 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 23 23:51:00 volumio systemd[1]: shairport-sync.service: Succeeded. Feb 23 23:51:00 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 23 23:51:00 volumio sudo[1646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 23 23:51:01 volumio volumio[979]: error: error Feb 23 23:51:00 volumio sudo[1646]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:51:01 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 23 23:51:00 volumio sudo[1637]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 23 23:51:00 volumio sudo[1637]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:51:00 volumio sudo[1637]: pam_unix(sudo:session): session closed for user root Feb 23 23:51:01 volumio sudo[1639]: pam_unix(sudo:session): session closed for user root Feb 23 23:51:01 volumio volumio[979]: info: Shairport-Sync Started Feb 23 23:51:01 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 23 23:51:01 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Feb 23 23:51:01 volumio systemd[1]: shairport-sync.service: Succeeded. Feb 23 23:51:01 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 23 23:51:01 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 23 23:51:01 volumio sudo[1646]: pam_unix(sudo:session): session closed for user root Feb 23 23:51:01 volumio volumio[979]: info: Shairport-Sync Started Feb 23 23:51:02 volumio mpd[1650]: Feb 23 23:51 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 23 23:51:02 volumio systemd[1]: Started Music Player Daemon. Feb 23 23:51:02 volumio sudo[1631]: pam_unix(sudo:session): session closed for user root Feb 23 23:51:02 volumio sudo[1617]: pam_unix(sudo:session): session closed for user root Feb 23 23:51:02 volumio volumio[979]: error: MPD error: The expression evaluated to a falsy value: Feb 23 23:51:02 volumio volumio[979]: assert.ok(self.idling) Feb 23 23:51:02 volumio volumio[979]: error: The expression evaluated to a falsy value: Feb 23 23:51:02 volumio volumio[979]: assert.ok(self.idling) Feb 23 23:51:02 volumio volumio[979]: error: updateQueue error: null Feb 23 23:51:02 volumio volumio[979]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Feb 23 23:51:02 volumio volumio[979]: info: camilladsp service started and running in background, instance 1 Feb 23 23:51:02 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 23 23:51:02 volumio volumio[979]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Feb 23 23:51:02 volumio volumio[979]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Feb 23 23:51:02 volumio volumio[979]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Feb 23 23:51:02 volumio volumio[979]: info: FusionDsp loaded Feb 23 23:51:02 volumio volumio[979]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 23 23:51:02 volumio sudo[1666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Feb 23 23:51:02 volumio sudo[1666]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 23 23:51:02 volumio volumio[979]: info: FusionDsp - Reporting Fusion DSP Enabled Feb 23 23:51:02 volumio volumio[979]: info: Adding Signal Path Element [object Object] Feb 23 23:51:02 volumio volumio[979]: info: Adding fusiondspeq DSP Signal Path Element Feb 23 23:51:02 volumio volumio[979]: info: FusionDsp - ---- installed callbackRead Feb 23 23:51:02 volumio volumio[979]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 23:51:02 volumio sudo[1666]: pam_unix(sudo:session): session closed for user root Feb 23 23:51:02 volumio volumio[979]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Feb 23 23:51:02 volumio volumio[979]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Feb 23 23:51:02 volumio volumio[979]: at onErrorNT (internal/child_process.js:465:16) Feb 23 23:51:02 volumio volumio[979]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Feb 23 23:51:02 volumio volumio[979]: errno: -2, Feb 23 23:51:02 volumio volumio[979]: code: 'ENOENT', Feb 23 23:51:02 volumio volumio[979]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Feb 23 23:51:02 volumio volumio[979]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Feb 23 23:51:02 volumio volumio[979]: spawnargs: [ Feb 23 23:51:02 volumio volumio[979]: '-p', Feb 23 23:51:02 volumio volumio[979]: 9876, Feb 23 23:51:02 volumio volumio[979]: '-o', Feb 23 23:51:02 volumio volumio[979]: '/tmp/camilladsp.log', Feb 23 23:51:02 volumio volumio[979]: '-l', Feb 23 23:51:02 volumio volumio[979]: 'warn', Feb 23 23:51:02 volumio volumio[979]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Feb 23 23:51:02 volumio volumio[979]: ] Feb 23 23:51:02 volumio volumio[979]: } Feb 23 23:51:02 volumio volumio[979]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 23 23:51:03 volumio sudo[1680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-23 23:50 Feb 23 23:51:03 volumio sudo[1680]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"