-- Logs begin at Fri 2025-12-12 02:47:33 JST, end at Tue 2025-12-30 13:17:42 JST. -- Dec 30 13:17:30 jbl-4312 systemd-timedated[3378]: Changed local time to Tue Dec 30 13:17:30 2025 Dec 30 13:17:30 jbl-4312 sudo[3352]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:30 jbl-4312 volumio-time-update[2851]: volumio-time-update-util: System time updated successfully. Dec 30 13:17:30 jbl-4312 systemd[1]: Starting Daily man-db regeneration... Dec 30 13:17:30 jbl-4312 systemd[1]: Starting Daily apt download activities... Dec 30 13:17:30 jbl-4312 systemd[1]: Started Volumio Time Update Utility. Dec 30 13:17:30 jbl-4312 systemd[1]: Reached target Multi-User System. Dec 30 13:17:30 jbl-4312 systemd[1]: Reached target Graphical Interface. Dec 30 13:17:30 jbl-4312 systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 30 13:17:30 jbl-4312 ntpd[3301]: Soliciting pool server 160.25.135.55 Dec 30 13:17:30 jbl-4312 ntpd[3301]: Soliciting pool server 162.159.200.1 Dec 30 13:17:30 jbl-4312 ntpd[3301]: Soliciting pool server 45.76.211.39 Dec 30 13:17:30 jbl-4312 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Dec 30 13:17:30 jbl-4312 systemd[1]: Started Update UTMP about System Runlevel Changes. Dec 30 13:17:30 jbl-4312 systemd[1]: man-db.service: Succeeded. Dec 30 13:17:30 jbl-4312 systemd[1]: Started Daily man-db regeneration. Dec 30 13:17:30 jbl-4312 ntpd[3301]: Soliciting pool server 129.250.35.250 Dec 30 13:17:30 jbl-4312 volumio[3102]: info: Loading plugin "qobuz"... Dec 30 13:17:31 jbl-4312 ntpd[3301]: Soliciting pool server 167.179.119.205 Dec 30 13:17:31 jbl-4312 ntpd[3301]: Soliciting pool server 5.104.87.198 Dec 30 13:17:31 jbl-4312 ntpd[3301]: Soliciting pool server 92.112.53.182 Dec 30 13:17:32 jbl-4312 ntpd[3301]: Soliciting pool server 153.127.38.46 Dec 30 13:17:32 jbl-4312 ntpd[3301]: Soliciting pool server 108.160.132.224 Dec 30 13:17:32 jbl-4312 systemd[1]: apt-daily.service: Succeeded. Dec 30 13:17:32 jbl-4312 systemd[1]: Started Daily apt download activities. Dec 30 13:17:32 jbl-4312 systemd[1]: Starting Daily apt upgrade and clean activities... Dec 30 13:17:32 jbl-4312 volumio-remote-updater[2850]: [2025-12-30 13:17:32] [connect] Successful connection Dec 30 13:17:32 jbl-4312 volumio[3102]: info: Plugin smart_inputs is not enabled Dec 30 13:17:32 jbl-4312 volumio[3102]: info: Loading plugin "tidal"... Dec 30 13:17:33 jbl-4312 ntpd[3301]: Soliciting pool server 129.250.35.251 Dec 30 13:17:33 jbl-4312 ntpd[3301]: Soliciting pool server 2400:8902::f03c:91ff:fe50:f5f0 Dec 30 13:17:34 jbl-4312 systemd[1]: apt-daily-upgrade.service: Succeeded. Dec 30 13:17:34 jbl-4312 systemd[1]: Started Daily apt upgrade and clean activities. Dec 30 13:17:34 jbl-4312 systemd[1]: Startup finished in 12.851s (kernel) + 24.521s (userspace) = 37.372s. Dec 30 13:17:34 jbl-4312 ntpd[3301]: Soliciting pool server 85.121.50.82 Dec 30 13:17:34 jbl-4312 volumio[3102]: info: Loading plugin "rivopluscontrol"... Dec 30 13:17:34 jbl-4312 volumio[3102]: info: Adding this device properties Dec 30 13:17:34 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties Dec 30 13:17:34 jbl-4312 volumio[3102]: info: Setting Additional Device Volumio Properties: [object Object] Dec 30 13:17:34 jbl-4312 volumio[3102]: info: Loading plugin "updater_comm"... Dec 30 13:17:35 jbl-4312 volumio[3102]: info: Loading plugin "cec_controller"... Dec 30 13:17:35 jbl-4312 volumio[3102]: info: Applying required configuration parameters for plugin cec_controller Dec 30 13:17:35 jbl-4312 volumio[3102]: info: Plugin mpdemulation is not enabled Dec 30 13:17:35 jbl-4312 volumio[3102]: info: Loading plugin "rest_api"... Dec 30 13:17:35 jbl-4312 volumio[3102]: info: Loading plugin "websocket"... Dec 30 13:17:35 jbl-4312 volumio[3102]: info: Starting Socket.io Server version 2.3.0 Dec 30 13:17:35 jbl-4312 volumio[3102]: info: Loading plugin "fusiondsp"... Dec 30 13:17:35 jbl-4312 volumio[3102]: info: Applying required configuration parameters for plugin fusiondsp Dec 30 13:17:36 jbl-4312 volumio[3102]: info: Loading i18n strings for locale ja Dec 30 13:17:36 jbl-4312 volumio[3102]: Updating browse sources language Dec 30 13:17:36 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 13:17:37 jbl-4312 ntpd[3301]: receive: Unexpected origin timestamp 0xecfdd0e0.1ca70037 does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xecfdd0e1.8b80f854 Dec 30 13:17:37 jbl-4312 ntpd[3301]: receive: Unexpected origin timestamp 0xecfdd0e0.1ca2a841 does not match aorg 0000000000.00000000 from server@160.25.135.55 xmt 0xecfdd0e1.8c9f1a24 Dec 30 13:17:37 jbl-4312 ntpd[3301]: receive: Unexpected origin timestamp 0xecfdd0e0.1c8c5eb2 does not match aorg 0000000000.00000000 from server@85.121.50.82 xmt 0xecfdd0e1.8ca05936 Dec 30 13:17:37 jbl-4312 ntpd[3301]: receive: Unexpected origin timestamp 0xecfdd0e0.1c9bf0af does not match aorg 0000000000.00000000 from server@167.179.119.205 xmt 0xecfdd0e1.8c759b48 Dec 30 13:17:37 jbl-4312 ntpd[3301]: receive: Unexpected origin timestamp 0xecfdd0e0.1ca05e7b does not match aorg 0000000000.00000000 from server@45.76.211.39 xmt 0xecfdd0e1.8ca60cb7 Dec 30 13:17:37 jbl-4312 ntpd[3301]: receive: Unexpected origin timestamp 0xecfdd0e0.1c957f70 does not match aorg 0000000000.00000000 from server@129.250.35.251 xmt 0xecfdd0e1.8c57084e Dec 30 13:17:37 jbl-4312 ntpd[3301]: receive: Unexpected origin timestamp 0xecfdd0e0.1c994312 does not match aorg 0000000000.00000000 from server@153.127.38.46 xmt 0xecfdd0e1.8ef58b38 Dec 30 13:17:37 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 13:17:37 jbl-4312 volumio[3102]: info: CoreCommandRouter::initPlayerControls Dec 30 13:17:37 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:37 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:37 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:37 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:37 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:37 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:37 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:37 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:37 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 30 13:17:37 jbl-4312 volumio[3102]: Express server listening on port 3000 Dec 30 13:17:37 jbl-4312 volumio[3102]: [Metrics] WebUI: 18s 590.49ms Dec 30 13:17:37 jbl-4312 volumio[3102]: info: CoreStateMachine::resetVolumioState Dec 30 13:17:37 jbl-4312 volumio[3102]: info: CoreStateMachine::getcurrentVolume Dec 30 13:17:37 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioRetrievevolume Dec 30 13:17:37 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 13:17:37 jbl-4312 volumio[3102]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Dec 30 13:17:37 jbl-4312 volumio[3102]: info: Completed loading Core Plugins Dec 30 13:17:37 jbl-4312 volumio[3102]: info: Preparing to generate the ALSA configuration file Dec 30 13:17:37 jbl-4312 volumio[3102]: info: Cannot read play queue from file Dec 30 13:17:38 jbl-4312 volumio[3102]: info: Volumio Network Manager: Network status updated: 0 Dec 30 13:17:38 jbl-4312 volumio[3102]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Dec 30 13:17:38 jbl-4312 volumio[3102]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 30 13:17:38 jbl-4312 volumio[3102]: info: Reading ALSA contributions from plugins. Dec 30 13:17:38 jbl-4312 volumio[3102]: verbose: New Socket.io Connection to 192.168.3.4 from 192.168.3.13 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 1 Dec 30 13:17:38 jbl-4312 volumio[3102]: verbose: New Socket.io Connection to 192.168.3.4 from 192.168.3.13 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 2 Dec 30 13:17:38 jbl-4312 volumio-remote-updater[2850]: [2025-12-30 13:17:38] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1767068252 101 Dec 30 13:17:38 jbl-4312 volumio[3102]: 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: 3 Dec 30 13:17:38 jbl-4312 volumio[3102]: verbose: New Socket.io Connection to 192.168.3.4 from 192.168.3.13 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 4 Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreStateMachine::setRepeat null single undefined Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreStateMachine::pushState Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CorePlayQueue::getTrack 0 Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioPushState Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreStateMachine::setRandom null Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreStateMachine::pushState Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CorePlayQueue::getTrack 0 Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioPushState Dec 30 13:17:38 jbl-4312 volumio[3102]: info: VolumeController:: Volume=100 Mute =false Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreStateMachine::pushState Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CorePlayQueue::getTrack 0 Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioPushState Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreStateMachine::updateTrackBlock Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CorePlayQueue::getTrackBlock Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioRetrievevolume Dec 30 13:17:38 jbl-4312 volumio[3102]: info: Asound.conf file unchanged, so no further update is needed Dec 30 13:17:38 jbl-4312 volumio[3102]: info: Output device has changed, restarting MPD Dec 30 13:17:38 jbl-4312 sudo[3514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 30 13:17:38 jbl-4312 sudo[3514]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:38 jbl-4312 volumio[3102]: info: ___________ START PLUGINS ___________ Dec 30 13:17:38 jbl-4312 sudo[3514]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:38 jbl-4312 sudo[3516]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 30 13:17:38 jbl-4312 sudo[3516]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:38 jbl-4312 volumio[3102]: info: ControllerMpd::onStart: Initializing MPD Dec 30 13:17:38 jbl-4312 volumio[3102]: info: Creating MPD Configuration file Dec 30 13:17:38 jbl-4312 sudo[3520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service Dec 30 13:17:38 jbl-4312 sudo[3520]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:38 jbl-4312 sudo[3523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 30 13:17:38 jbl-4312 systemd[1]: Listening on mpd.socket. Dec 30 13:17:38 jbl-4312 sudo[3523]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 30 13:17:38 jbl-4312 systemd[1]: Starting Music Player Daemon... Dec 30 13:17:38 jbl-4312 volumio[3102]: info: [1767068258478] CoreMusicLibrary::Adding element Last_100 Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 13:17:38 jbl-4312 sudo[3523]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:38 jbl-4312 volumio[3102]: info: Streaming services startup Dec 30 13:17:38 jbl-4312 volumio[3102]: info: Starting Streaming Daemon Dec 30 13:17:38 jbl-4312 systemd[1]: Started Volumio5 Onboarding Server. Dec 30 13:17:38 jbl-4312 sudo[3525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 30 13:17:38 jbl-4312 sudo[3525]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:38 jbl-4312 sudo[3520]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:38 jbl-4312 sudo[3531]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Dec 30 13:17:38 jbl-4312 sudo[3531]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:38 jbl-4312 systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 30 13:17:38 jbl-4312 systemd[1]: mpd.service: Succeeded. Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 30 13:17:38 jbl-4312 systemd[1]: Stopped Music Player Daemon. Dec 30 13:17:38 jbl-4312 volumio[3102]: info: [1767068258585] CoreMusicLibrary::Adding element Webradio Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 30 13:17:38 jbl-4312 volumio[3102]: info: Initializing BBC Radios Dec 30 13:17:38 jbl-4312 systemd[1]: Starting Music Player Daemon... Dec 30 13:17:38 jbl-4312 sudo[3531]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 13:17:38 jbl-4312 volumio[3102]: info: Creating Spotify config file Dec 30 13:17:38 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:38 jbl-4312 volumio[3102]: error: Hi Res Audio Failed Login: Missing Login Data Dec 30 13:17:38 jbl-4312 volumio[3102]: info: Adding HIGHRESAUDIO REST API Endpoints Dec 30 13:17:38 jbl-4312 volumio[3102]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Dec 30 13:17:38 jbl-4312 volumio[3102]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Dec 30 13:17:38 jbl-4312 volumio[3102]: info: Initializing Serial Communication on port /dev/ttyS3 Dec 30 13:17:38 jbl-4312 volumio[3102]: info: Touch Event Listener Process Starting Dec 30 13:17:38 jbl-4312 kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600 Dec 30 13:17:38 jbl-4312 kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600 Dec 30 13:17:38 jbl-4312 kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200 Dec 30 13:17:38 jbl-4312 sudo[3537]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 30 13:17:38 jbl-4312 sudo[3537]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:38 jbl-4312 sudo[3537]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 30 13:17:38 jbl-4312 sudo[3537]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:38 jbl-4312 sudo[3554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root Dec 30 13:17:38 jbl-4312 sudo[3554]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:38 jbl-4312 sudo[3554]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:38 jbl-4312 sudo[3564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0 Dec 30 13:17:38 jbl-4312 sudo[3564]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:38 jbl-4312 sudo[3564]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:39 jbl-4312 volumio5-onboarding[3529]: time=2025-12-30T13:17:39.005+09:00 level=INFO msg="running volumio5-device-gateway" version=5bca5789+CHANGES buildDate=2025-12-11T14:07:23Z Dec 30 13:17:39 jbl-4312 sudo[3567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0 Dec 30 13:17:39 jbl-4312 sudo[3567]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:39 jbl-4312 sudo[3567]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:39 jbl-4312 sudo[3571]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1 Dec 30 13:17:39 jbl-4312 sudo[3571]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:39 jbl-4312 sudo[3571]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:39 jbl-4312 sudo[3574]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1 Dec 30 13:17:39 jbl-4312 sudo[3574]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:39 jbl-4312 sudo[3574]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Apply VIM3L Onboard LEDs Settings Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Turning On Onboard LEDs Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Starting CEC Event listener Dec 30 13:17:39 jbl-4312 sudo[3578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger Dec 30 13:17:39 jbl-4312 sudo[3578]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Loading i18n strings for locale ja Dec 30 13:17:39 jbl-4312 sudo[3578]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:39 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 30 13:17:39 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:39 jbl-4312 volumio[3102]: info: FusionDsp - mixtype--------------------- Hardware Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Volumio Calling Home Dec 30 13:17:39 jbl-4312 sudo[3582]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger Dec 30 13:17:39 jbl-4312 sudo[3582]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:39 jbl-4312 sudo[3582]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Preparing to generate the ALSA configuration file Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Stopping AccessToken refresher cron for QOBUZ Dec 30 13:17:39 jbl-4312 volumio[3102]: info: AccessToken refresher cron started for QOBUZ Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Adding TIDAL REST API Endpoints Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Adding QOBUZ REST API Endpoints Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Discovery: adding 477e6b25-e4ef-4cfb-b828-303619ebc483 Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Discovery: Found device JBL 4312 Dec 30 13:17:39 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioGetState Dec 30 13:17:39 jbl-4312 volumio[3102]: info: CorePlayQueue::getTrack 0 Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Serial port opened successfully Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Sending serial start messages Dec 30 13:17:39 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Reporting MCU Network Status: 0 Dec 30 13:17:39 jbl-4312 volumio[3102]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Reading ALSA contributions from plugins. Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Touch Event Listener Process Closed Dec 30 13:17:39 jbl-4312 volumio[3102]: error: Cannot start Volumio Streaming Daemon Dec 30 13:17:39 jbl-4312 volumio[3102]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Dec 30 13:17:39 jbl-4312 volumio[3102]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Dec 30 13:17:39 jbl-4312 volumio[3102]: info: MPD Permissions set Dec 30 13:17:39 jbl-4312 volumio[3102]: info: MPD Permissions set Dec 30 13:17:39 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Setting Device Volume Override Dec 30 13:17:39 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioUpdateVolumeSettings Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Updating Volume Controller Parameters: Device: 5 Name: SMSL USB AUDIO Mixer: SMSL USB AUDIO Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Dec 30 13:17:39 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Dec 30 13:17:39 jbl-4312 volumio[3102]: info: Disabling external Volume Control Dec 30 13:17:39 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:39 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:39 jbl-4312 volumio[3102]: info: CoreStateMachine::pushState Dec 30 13:17:39 jbl-4312 volumio[3102]: info: CorePlayQueue::getTrack 0 Dec 30 13:17:39 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:17:39 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioPushState Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Discovery: A device disappeared from network Dec 30 13:17:40 jbl-4312 volumio[3102]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Spotify config file written Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Setting Additional System Software info: Hardware Revision: 1.0 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Dec 30 13:17:40 jbl-4312 volumio5-onboarding[3529]: time=2025-12-30T13:17:40.113+09:00 level=INFO msg="listening for BLE messages" address=B8:13:32:E4:3F:CF%00 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Setting HW Firmware info: undefined Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Setting HW Version info: 1.0 Dec 30 13:17:40 jbl-4312 volumio5-onboarding[3529]: time=2025-12-30T13:17:40.114+09:00 level=INFO msg="listening for WebSocket messages" address=[::]:7331 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Setting Additional System Software info: Hardware Revision: 1.0, Firmware Version: 0.3.0 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Setting HW Firmware info: 0.3.0 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Setting HW Version info: 1.0 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff Dec 30 13:17:40 jbl-4312 volumio[3102]: info: MCU Signalled Headphone Mode Disabled Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState Dec 30 13:17:40 jbl-4312 volumio[3102]: info: MCU Signalled Sleep Mode Disabled Dec 30 13:17:40 jbl-4312 sudo[3594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service Dec 30 13:17:40 jbl-4312 sudo[3594]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Enabling Advanced system settings configuration Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Additional UI Settings Added for plugin music_service/inputs Dec 30 13:17:40 jbl-4312 volumio[3102]: info: MCU Signalled Auto Boot Mode On Power Disabled Dec 30 13:17:40 jbl-4312 sudo[3600]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on Dec 30 13:17:40 jbl-4312 sudo[3600]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:40 jbl-4312 systemd[1]: Started go-librespot Daemon. Dec 30 13:17:40 jbl-4312 sudo[3594]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:40 jbl-4312 sudo[3600]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:40 jbl-4312 go-librespot[3603]: go-librespot daemon starting... Dec 30 13:17:40 jbl-4312 volumio[3102]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: Go-http-client/1.1 Engine version: 3 Transport: websocket Total Clients: 5 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Received Get System Info Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Discovery: Getting this device information Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioGetState Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CorePlayQueue::getTrack 0 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 13:17:40 jbl-4312 volumio[3102]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Volumio called home Dec 30 13:17:40 jbl-4312 volumio[3102]: info: VolumeController:: Volume=100 Mute =false Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreStateMachine::pushState Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CorePlayQueue::getTrack 0 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioPushState Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 go-librespot[3603]: time="2025-12-30T13:17:40+09:00" level=info msg="running go-librespot 0.4.0" Dec 30 13:17:40 jbl-4312 go-librespot[3603]: time="2025-12-30T13:17:40+09:00" level=debug msg="app state loaded" Dec 30 13:17:40 jbl-4312 go-librespot[3603]: time="2025-12-30T13:17:40+09:00" level=debug msg="stored credentials not found" Dec 30 13:17:40 jbl-4312 go-librespot[3603]: time="2025-12-30T13:17:40+09:00" level=info msg="api server listening on 127.0.0.1:9879" Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:40 jbl-4312 volumio[3102]: info: No need to fix Spotify hosts Dec 30 13:17:40 jbl-4312 volumio[3102]: error: Serial API: Failed to decode command: MAXVOL, message: 100 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 30 13:17:40 jbl-4312 volumio5-onboarding[3529]: time=2025-12-30T13:17:40.611+09:00 level=INFO msg="BLE descriptor updated" deviceId=22366d4cda9f547124971b6f96d9907a deviceName="JBL 4312" deviceModel=0x19028b0 Dec 30 13:17:40 jbl-4312 volumio5-onboarding[3529]: time=2025-12-30T13:17:40.612+09:00 level=INFO msg="mDNS descriptor updated" deviceId=22366d4cda9f547124971b6f96d9907a deviceName="JBL 4312" deviceModel=0x19028b0 Dec 30 13:17:40 jbl-4312 volumio5-onboarding[3529]: time=2025-12-30T13:17:40.622+09:00 level=INFO msg="bootstrapping state" hasInternet=true Dec 30 13:17:40 jbl-4312 volumio[3102]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Received Get System Info Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Discovery: Getting this device information Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioGetState Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CorePlayQueue::getTrack 0 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 13:17:40 jbl-4312 sudo[3626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0 Dec 30 13:17:40 jbl-4312 sudo[3626]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:40 jbl-4312 sudo[3626]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:40 jbl-4312 volumio[3102]: info: VolumeController:: Volume=100 Mute =false Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreStateMachine::pushState Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CorePlayQueue::getTrack 0 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioPushState Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Discovery: adding 477e6b25-e4ef-4cfb-b828-303619ebc483 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Discovery: Found device JBL 4312 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioGetState Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CorePlayQueue::getTrack 0 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: MP1 GPIO: Signalled system ready via GPIO Dec 30 13:17:40 jbl-4312 volumio-remote-updater[2850]: No test mode Dec 30 13:17:40 jbl-4312 volumio-remote-updater[2850]: No alpha test mode Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Adding Inputs via Serial API Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Adding Advanced Audio Settings via Serial API Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Additional UI Settings Added for plugin music_service/inputs Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreStateMachine::pushState Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CorePlayQueue::getTrack 0 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioPushState Dec 30 13:17:40 jbl-4312 go-librespot[3603]: time="2025-12-30T13:17:40+09:00" level=debug msg="fetched new accesspoints: [ap-gae2.spotify.com:4070 ap-gae2.spotify.com:443 ap-gae2.spotify.com:80 ap-guc3.spotify.com:4070 ap-gue1.spotify.com:443 ap-gew4.spotify.com:80]" Dec 30 13:17:40 jbl-4312 go-librespot[3603]: time="2025-12-30T13:17:40+09:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gue1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]" Dec 30 13:17:40 jbl-4312 go-librespot[3603]: time="2025-12-30T13:17:40+09:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gue1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]" Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioGetState Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CorePlayQueue::getTrack 0 Dec 30 13:17:40 jbl-4312 go-librespot[3603]: time="2025-12-30T13:17:40+09:00" level=info msg="zeroconf server listening on port 46481" Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CoreCommandRouter::volumioGetState Dec 30 13:17:40 jbl-4312 volumio[3102]: info: CorePlayQueue::getTrack 0 Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Asound.conf file unchanged, so no further update is needed Dec 30 13:17:40 jbl-4312 volumio[3102]: info: Output device has changed, restarting MPD Dec 30 13:17:41 jbl-4312 sudo[3633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 30 13:17:41 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:41 jbl-4312 sudo[3633]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:41 jbl-4312 sudo[3633]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:41 jbl-4312 sudo[3635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 30 13:17:41 jbl-4312 sudo[3635]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:41 jbl-4312 volumio[3102]: info: MPD Permissions set Dec 30 13:17:41 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:41 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:41 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:41 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:41 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:41 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:41 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:41 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:41 jbl-4312 systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 30 13:17:41 jbl-4312 systemd[1]: mpd.service: Succeeded. Dec 30 13:17:41 jbl-4312 systemd[1]: Stopped Music Player Daemon. Dec 30 13:17:41 jbl-4312 systemd[1]: Starting Music Player Daemon... Dec 30 13:17:41 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 30 13:17:41 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Dec 30 13:17:41 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:41 jbl-4312 sudo[3639]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 30 13:17:41 jbl-4312 sudo[3639]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:41 jbl-4312 sudo[3639]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 30 13:17:41 jbl-4312 sudo[3639]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:41 jbl-4312 volumio5-onboarding[3529]: time=2025-12-30T13:17:41.399+09:00 level=INFO msg="established new WebSocket connection" component=conn/ws remoteAddr=192.168.3.13:57927 Dec 30 13:17:41 jbl-4312 volumio[3102]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Dec 30 13:17:41 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Dec 30 13:17:41 jbl-4312 volumio[3102]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Dec 30 13:17:41 jbl-4312 volumio[3102]: info: camilladsp service started and running in background, instance 1 Dec 30 13:17:41 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 30 13:17:41 jbl-4312 volumio[3102]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Dec 30 13:17:41 jbl-4312 volumio[3102]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Dec 30 13:17:41 jbl-4312 volumio[3102]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Dec 30 13:17:41 jbl-4312 volumio[3102]: info: FusionDsp loaded Dec 30 13:17:41 jbl-4312 volumio[3102]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 13:17:41 jbl-4312 sudo[3658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Dec 30 13:17:41 jbl-4312 sudo[3658]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 13:17:41 jbl-4312 volumio[3102]: info: FusionDsp - Reporting Fusion DSP Enabled Dec 30 13:17:41 jbl-4312 volumio[3102]: info: Adding Signal Path Element [object Object] Dec 30 13:17:41 jbl-4312 volumio[3102]: info: Adding fusiondspeq DSP Signal Path Element Dec 30 13:17:41 jbl-4312 volumio[3102]: info: FusionDsp - ---- installed callbackRead Dec 30 13:17:41 jbl-4312 volumio[3102]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 13:17:41 jbl-4312 sudo[3658]: pam_unix(sudo:session): session closed for user root Dec 30 13:17:41 jbl-4312 volumio[3102]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Dec 30 13:17:41 jbl-4312 volumio[3102]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Dec 30 13:17:41 jbl-4312 volumio[3102]: at onErrorNT (internal/child_process.js:472:16) Dec 30 13:17:41 jbl-4312 volumio[3102]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Dec 30 13:17:41 jbl-4312 volumio[3102]: errno: -2, Dec 30 13:17:41 jbl-4312 volumio[3102]: code: 'ENOENT', Dec 30 13:17:41 jbl-4312 volumio[3102]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Dec 30 13:17:41 jbl-4312 volumio[3102]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Dec 30 13:17:41 jbl-4312 volumio[3102]: spawnargs: [ Dec 30 13:17:41 jbl-4312 volumio[3102]: '-p', Dec 30 13:17:41 jbl-4312 volumio[3102]: 9876, Dec 30 13:17:41 jbl-4312 volumio[3102]: '-o', Dec 30 13:17:41 jbl-4312 volumio[3102]: '/tmp/camilladsp.log', Dec 30 13:17:41 jbl-4312 volumio[3102]: '-l', Dec 30 13:17:41 jbl-4312 volumio[3102]: 'warn', Dec 30 13:17:41 jbl-4312 volumio[3102]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Dec 30 13:17:41 jbl-4312 volumio[3102]: ] Dec 30 13:17:41 jbl-4312 volumio[3102]: } Dec 30 13:17:41 jbl-4312 volumio[3102]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 13:17:42 jbl-4312 sudo[3669]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-30 13:16 Dec 30 13:17:42 jbl-4312 sudo[3669]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="2f25e1a98e53e2dbc4f3878604e250b0379f3ea4" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivoplus" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 06:47:33 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo Plus" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo Plus" VOLUMIO_HASH="9e8aa5d6afb5e5d87a87bafae7aa5647"