-- Logs begin at Thu 2023-02-23 09:49:45 JST, end at Sat 2025-09-13 14:51:20 JST. --
Sep 13 14:50:53 volumio systemd[1]: Starting Daily apt download activities...
Sep 13 14:50:55 volumio volumio[665]: info: Applying required configuration parameters for plugin serialampcontroller
Sep 13 14:50:55 volumio volumio[665]: info: Applying required configuration parameters for plugin serialampcontroller
Sep 13 14:50:55 volumio systemd[1]: apt-daily.service: Succeeded.
Sep 13 14:50:55 volumio systemd[1]: Started Daily apt download activities.
Sep 13 14:50:55 volumio systemd[1]: Starting Daily apt upgrade and clean activities...
Sep 13 14:50:55 volumio volumio[665]: info: Loading i18n strings for locale ja
Sep 13 14:50:56 volumio volumio[665]: Updating browse sources language
Sep 13 14:50:56 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 13 14:50:57 volumio systemd[1]: apt-daily-upgrade.service: Succeeded.
Sep 13 14:50:57 volumio systemd[1]: Started Daily apt upgrade and clean activities.
Sep 13 14:50:58 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 13 14:50:58 volumio volumio[665]: info: CoreCommandRouter::initPlayerControls
Sep 13 14:50:58 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:50:58 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:50:58 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:50:58 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:50:58 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:50:58 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:50:58 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:50:58 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:50:58 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 13 14:50:58 volumio volumio[665]: Express server listening on port 3000
Sep 13 14:50:58 volumio volumio[665]: [Metrics] WebUI: 45s 249.36ms
Sep 13 14:50:58 volumio volumio-remote-updater[325]: [2025-09-13 14:50:58] [connect] Successful connection
Sep 13 14:50:58 volumio volumio[665]: info: CoreStateMachine::resetVolumioState
Sep 13 14:50:58 volumio volumio[665]: info: CoreStateMachine::getcurrentVolume
Sep 13 14:50:58 volumio volumio[665]: info: CoreCommandRouter::volumioRetrievevolume
Sep 13 14:50:58 volumio volumio[665]: info: CoreStateMachine::pushState
Sep 13 14:50:58 volumio volumio[665]: info: CorePlayQueue::getTrack 0
Sep 13 14:50:58 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 13 14:50:58 volumio volumio[665]: info: CoreCommandRouter::volumioPushState
Sep 13 14:50:59 volumio sudo[835]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Sep 13 14:50:59 volumio sudo[835]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 13 14:50:59 volumio sudo[837]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Sep 13 14:50:59 volumio sudo[837]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 13 14:50:59 volumio sudo[835]: pam_unix(sudo:session): session closed for user root
Sep 13 14:50:59 volumio sudo[837]: pam_unix(sudo:session): session closed for user root
Sep 13 14:50:59 volumio volumio[665]: info: MPD Permissions set
Sep 13 14:51:00 volumio volumio-remote-updater[325]: [2025-09-13 14:51:00] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1757742658 101
Sep 13 14:51:00 volumio volumio[665]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 1
Sep 13 14:51:00 volumio volumio[665]: info: MPD running with PID719
Sep 13 14:51:00 volumio volumio[665]: ,establishing connection
Sep 13 14:51:01 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:51:01 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:51:01 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:51:01 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:51:01 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:51:01 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:51:01 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:51:01 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:51:02 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 13 14:51:02 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:51:02 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 13 14:51:02 volumio volumio[665]: info: Reloading queue from file
Sep 13 14:51:02 volumio volumio[665]: error: updateQueue error: null
Sep 13 14:51:02 volumio volumio[665]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Sep 13 14:51:06 volumio volumio[665]: Cannot compose Albumart path
Sep 13 14:51:06 volumio volumio[665]: Cannot compose Albumart path
Sep 13 14:51:06 volumio volumio[665]: Cannot compose Albumart path
Sep 13 14:51:06 volumio volumio[665]: Cannot compose Albumart path
Sep 13 14:51:06 volumio volumio[665]: Cannot compose Albumart path
Sep 13 14:51:06 volumio volumio[665]: Cannot compose Albumart path
Sep 13 14:51:07 volumio volumio[665]: info: CoreStateMachine::setRepeat null single undefined
Sep 13 14:51:07 volumio volumio[665]: info: CoreStateMachine::pushState
Sep 13 14:51:07 volumio volumio[665]: info: CorePlayQueue::getTrack 0
Sep 13 14:51:07 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Sep 13 14:51:07 volumio volumio[665]: info: CoreCommandRouter::volumioPushState
Sep 13 14:51:07 volumio volumio[665]: info: CoreStateMachine::setRandom null
Sep 13 14:51:07 volumio volumio[665]: info: CoreStateMachine::pushState
Sep 13 14:51:07 volumio volumio[665]: info: CorePlayQueue::getTrack 0
Sep 13 14:51:07 volumio volumio[665]: info: CoreCommandRouter::volumioPushState
Sep 13 14:51:07 volumio volumio[665]: info: Setting Device type: Raspberry PI
Sep 13 14:51:07 volumio volumio[665]: info: Completed loading Core Plugins
Sep 13 14:51:07 volumio volumio[665]: info: Preparing to generate the ALSA configuration file
Sep 13 14:51:07 volumio volumio[665]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Sep 13 14:51:07 volumio volumio[665]: info: Reading ALSA contributions from plugins.
Sep 13 14:51:07 volumio volumio[665]: info: Discovery: A device disappeared from network
Sep 13 14:51:07 volumio volumio[665]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined
Sep 13 14:51:07 volumio volumio[665]: error: updateQueue error: null
Sep 13 14:51:08 volumio volumio[665]: info: Discovery: adding ae3ac1bb-a296-4998-afd1-093e0bcf81d1
Sep 13 14:51:08 volumio volumio[665]: info: Discovery: Found device Volumio
Sep 13 14:51:08 volumio volumio[665]: info: CoreCommandRouter::volumioGetState
Sep 13 14:51:08 volumio volumio[665]: info: CorePlayQueue::getTrack 0
Sep 13 14:51:08 volumio sudo[855]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Sep 13 14:51:08 volumio sudo[855]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 13 14:51:08 volumio volumio[665]: info: Discovery: this is already registered, ae3ac1bb-a296-4998-afd1-093e0bcf81d1
Sep 13 14:51:08 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Sep 13 14:51:08 volumio volumio[665]: info: Discovery: Found device Volumio
Sep 13 14:51:08 volumio volumio[665]: info: CoreCommandRouter::volumioGetState
Sep 13 14:51:08 volumio volumio[665]: info: CorePlayQueue::getTrack 0
Sep 13 14:51:08 volumio sudo[855]: pam_unix(sudo:session): session closed for user root
Sep 13 14:51:08 volumio volumio[665]: info: Upmpdcli Daemon Started
Sep 13 14:51:08 volumio volumio[665]: info: Asound.conf file unchanged, so no further update is needed
Sep 13 14:51:08 volumio volumio[665]: info: Output device has changed, restarting MPD
Sep 13 14:51:08 volumio volumio[665]: info: Output device has changed, restarting Shairport Sync
Sep 13 14:51:08 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:51:08 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 13 14:51:08 volumio sudo[860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Sep 13 14:51:08 volumio sudo[860]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 13 14:51:08 volumio sudo[860]: pam_unix(sudo:session): session closed for user root
Sep 13 14:51:09 volumio sudo[862]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Sep 13 14:51:09 volumio sudo[862]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 13 14:51:09 volumio systemd[1]: Stopping Music Player Daemon...
Sep 13 14:51:09 volumio systemd[1]: mpd.service: Succeeded.
Sep 13 14:51:09 volumio systemd[1]: Stopped Music Player Daemon.
Sep 13 14:51:09 volumio systemd[1]: Starting Music Player Daemon...
Sep 13 14:51:09 volumio volumio[665]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 13 14:51:09 volumio volumio[665]: info: ___________ START PLUGINS ___________
Sep 13 14:51:09 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Sep 13 14:51:09 volumio volumio[665]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 13 14:51:09 volumio volumio[665]: info: [1757742669641] CoreMusicLibrary::Adding element Media Servers
Sep 13 14:51:09 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 13 14:51:09 volumio volumio[665]: Cannot find translation for sourceMedia Servers
Sep 13 14:51:09 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:51:09 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 13 14:51:10 volumio volumio[665]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 13 14:51:10 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:51:10 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 13 14:51:10 volumio volumio[665]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Sep 13 14:51:10 volumio volumio[665]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 13 14:51:10 volumio volumio[665]: info: [1757742670548] CoreMusicLibrary::Adding element Last_100
Sep 13 14:51:10 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 13 14:51:10 volumio volumio[665]: Cannot find translation for sourceMedia Servers
Sep 13 14:51:10 volumio volumio[665]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Sep 13 14:51:10 volumio volumio[665]: info: [1757742670584] CoreMusicLibrary::Adding element Webradio
Sep 13 14:51:10 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Sep 13 14:51:10 volumio volumio[665]: Cannot find translation for sourceMedia Servers
Sep 13 14:51:10 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 13 14:51:10 volumio volumio[665]: info: Loading i18n strings for locale ja
Sep 13 14:51:10 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Sep 13 14:51:10 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:51:10 volumio volumio[665]: info: FusionDsp - mixtype--------------------- None
Sep 13 14:51:10 volumio volumio[665]: info: Volumio Calling Home
Sep 13 14:51:11 volumio volumio[665]: info: Preparing to generate the ALSA configuration file
Sep 13 14:51:14 volumio volumio[665]: info: camilladsp service started and running in background, instance 1
Sep 13 14:51:14 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 13 14:51:14 volumio volumio[665]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 13 14:51:14 volumio volumio[665]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Sep 13 14:51:14 volumio volumio[665]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Sep 13 14:51:14 volumio volumio[665]: info: FusionDsp loaded
Sep 13 14:51:14 volumio volumio[665]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Sep 13 14:51:14 volumio sudo[891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Sep 13 14:51:14 volumio sudo[891]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 13 14:51:14 volumio sudo[891]: pam_unix(sudo:session): session closed for user root
Sep 13 14:51:14 volumio volumio[665]: info: FusionDsp - Reporting Fusion DSP Enabled
Sep 13 14:51:14 volumio volumio[665]: info: Adding Signal Path Element [object Object]
Sep 13 14:51:14 volumio volumio[665]: info: Adding fusiondspeq DSP Signal Path Element
Sep 13 14:51:14 volumio volumio[665]: info: FusionDsp - ---- installed callbackRead
Sep 13 14:51:14 volumio volumio[665]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 13 14:51:15 volumio volumio[665]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Sep 13 14:51:15 volumio volumio[665]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Sep 13 14:51:15 volumio volumio[665]: at onErrorNT (internal/child_process.js:465:16)
Sep 13 14:51:15 volumio volumio[665]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Sep 13 14:51:15 volumio volumio[665]: at runNextTicks (internal/process/task_queues.js:62:3)
Sep 13 14:51:15 volumio volumio[665]: at listOnTimeout (internal/timers.js:523:9)
Sep 13 14:51:15 volumio volumio[665]: at processTimers (internal/timers.js:497:7) {
Sep 13 14:51:15 volumio volumio[665]: errno: -2,
Sep 13 14:51:15 volumio volumio[665]: code: 'ENOENT',
Sep 13 14:51:15 volumio volumio[665]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 13 14:51:15 volumio volumio[665]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Sep 13 14:51:15 volumio volumio[665]: spawnargs: [
Sep 13 14:51:15 volumio volumio[665]: '-p',
Sep 13 14:51:15 volumio volumio[665]: 9876,
Sep 13 14:51:15 volumio volumio[665]: '-o',
Sep 13 14:51:15 volumio volumio[665]: '/tmp/camilladsp.log',
Sep 13 14:51:15 volumio volumio[665]: '-l',
Sep 13 14:51:15 volumio volumio[665]: 'warn',
Sep 13 14:51:15 volumio volumio[665]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Sep 13 14:51:15 volumio volumio[665]: ]
Sep 13 14:51:15 volumio volumio[665]: }
Sep 13 14:51:15 volumio volumio[665]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 13 14:51:19 volumio sudo[902]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-13 14:50
Sep 13 14:51:20 volumio sudo[902]: 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="1d63a568b7d5e4a317f16be7d0961cbb2d82e282"
VOLUMIO_FE_VERSION="c433755e569617abac52264d17ad61be303ef463"
VOLUMIO_FE3_VERSION="2419ddd8e895c5bdc456962163c9dc7c0f187aa7"
VOLUMIO_BE_VERSION="4f8978e0148ab5e1610548b80abf1b4b5e03ea0a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 07 Feb 2023 02:43:13 PM CET"
VOLUMIO_VERSION="3.429"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="3223bbb74b9427313a173f7908c19cfa"