-- Logs begin at Wed 2026-02-11 19:00:17 JST, end at Thu 2026-02-12 17:08:28 JST. --
Feb 12 17:08:16 integro systemd-timedated[3360]: Changed local time to Thu Feb 12 17:08:16 2026
Feb 12 17:08:16 integro sudo[3358]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:16 integro volumio-time-update[2818]: volumio-time-update-util: System time updated successfully.
Feb 12 17:08:16 integro systemd[1]: Started Volumio Time Update Utility.
Feb 12 17:08:16 integro systemd[1]: Starting Daily man-db regeneration...
Feb 12 17:08:16 integro systemd[1]: Starting Daily apt upgrade and clean activities...
Feb 12 17:08:16 integro systemd[1]: Reached target Multi-User System.
Feb 12 17:08:16 integro systemd[1]: Reached target Graphical Interface.
Feb 12 17:08:16 integro systemd[1]: Starting Update UTMP about System Runlevel Changes...
Feb 12 17:08:16 integro systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Feb 12 17:08:16 integro systemd[1]: Started Update UTMP about System Runlevel Changes.
Feb 12 17:08:16 integro ntpd[3274]: Soliciting pool server 172.105.192.74
Feb 12 17:08:16 integro ntpd[3274]: Soliciting pool server 43.167.237.61
Feb 12 17:08:16 integro ntpd[3274]: Soliciting pool server 162.159.200.1
Feb 12 17:08:16 integro volumio[3099]: info: Applying required configuration parameters for plugin hi_res_audio
Feb 12 17:08:16 integro volumio[3099]: info: Loading plugin "inputs"...
Feb 12 17:08:17 integro systemd[1]: man-db.service: Succeeded.
Feb 12 17:08:17 integro systemd[1]: Started Daily man-db regeneration.
Feb 12 17:08:17 integro volumio[3099]: info: Loading plugin "qobuz"...
Feb 12 17:08:17 integro ntpd[3274]: Soliciting pool server 129.250.35.251
Feb 12 17:08:17 integro ntpd[3274]: Soliciting pool server 163.44.119.85
Feb 12 17:08:17 integro ntpd[3274]: Soliciting pool server 172.233.91.137
Feb 12 17:08:18 integro volumio-remote-updater[2819]: [2026-02-12 17:08:18] [connect] Successful connection
Feb 12 17:08:18 integro systemd[1]: apt-daily-upgrade.service: Succeeded.
Feb 12 17:08:18 integro systemd[1]: Started Daily apt upgrade and clean activities.
Feb 12 17:08:18 integro systemd[1]: Startup finished in 13.046s (kernel) + 22.962s (userspace) = 36.008s.
Feb 12 17:08:18 integro ntpd[3274]: Soliciting pool server 165.140.142.8
Feb 12 17:08:18 integro ntpd[3274]: Soliciting pool server 2400:8905::2000:27ff:fe9b:4c1a
Feb 12 17:08:19 integro volumio[3099]: info: Plugin smart_inputs is not enabled
Feb 12 17:08:19 integro volumio[3099]: info: Loading plugin "tidal"...
Feb 12 17:08:19 integro ntpd[3274]: Soliciting pool server 85.121.122.62
Feb 12 17:08:21 integro volumio[3099]: info: Loading plugin "integrocontrol"...
Feb 12 17:08:21 integro volumio[3099]: info: Adding this device properties
Feb 12 17:08:21 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties
Feb 12 17:08:21 integro volumio[3099]: info: Setting Additional Device Volumio Properties: [object Object]
Feb 12 17:08:21 integro volumio[3099]: info: Loading plugin "updater_comm"...
Feb 12 17:08:21 integro volumio[3099]: info: Plugin mpdemulation is not enabled
Feb 12 17:08:21 integro volumio[3099]: info: Loading plugin "rest_api"...
Feb 12 17:08:21 integro volumio[3099]: info: Loading plugin "websocket"...
Feb 12 17:08:21 integro volumio[3099]: info: Starting Socket.io Server version 2.3.0
Feb 12 17:08:21 integro volumio[3099]: info: Loading plugin "fusiondsp"...
Feb 12 17:08:21 integro volumio[3099]: info: Applying required configuration parameters for plugin fusiondsp
Feb 12 17:08:22 integro volumio[3099]: info: Loading i18n strings for locale ja
Feb 12 17:08:22 integro volumio[3099]: Updating browse sources language
Feb 12 17:08:22 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 12 17:08:22 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 12 17:08:22 integro volumio[3099]: info: CoreCommandRouter::initPlayerControls
Feb 12 17:08:22 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:22 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:22 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:22 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:22 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:22 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:22 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:22 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:22 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 12 17:08:22 integro volumio[3099]: Express server listening on port 3000
Feb 12 17:08:22 integro volumio[3099]: [Metrics] WebUI: 18s 423.83ms
Feb 12 17:08:22 integro volumio[3099]: info: CoreStateMachine::resetVolumioState
Feb 12 17:08:22 integro volumio[3099]: info: CoreStateMachine::getcurrentVolume
Feb 12 17:08:22 integro volumio[3099]: info: CoreCommandRouter::volumioRetrievevolume
Feb 12 17:08:22 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 12 17:08:22 integro sudo[3480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 12 17:08:22 integro sudo[3480]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:22 integro volumio[3099]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Feb 12 17:08:22 integro sudo[3482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 12 17:08:22 integro sudo[3482]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:22 integro sudo[3480]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:22 integro volumio[3099]: info: Completed loading Core Plugins
Feb 12 17:08:22 integro volumio[3099]: info: Preparing to generate the ALSA configuration file
Feb 12 17:08:22 integro sudo[3482]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:22 integro volumio[3099]: info: Volumio Network Manager: Network status updated: 0
Feb 12 17:08:22 integro volumio[3099]: Unable to parse:
Feb 12 17:08:22 integro volumio[3099]: Simple mixer control 'Audio hdmi-out mute',0
Feb 12 17:08:22 integro volumio[3099]: Capabilities: pswitch pswitch-joined
Feb 12 17:08:22 integro volumio[3099]: Playback channels: Mono
Feb 12 17:08:22 integro volumio[3099]: Mono: Playback [on]
Feb 12 17:08:22 integro volumio[3099]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
Feb 12 17:08:22 integro volumio[3099]: info: Cannot mount NAS contents at system boot, trial number 1 ,retrying in 5 seconds
Feb 12 17:08:22 integro volumio[3099]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Feb 12 17:08:22 integro volumio[3099]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Feb 12 17:08:22 integro volumio[3099]: info: Reading ALSA contributions from plugins.
Feb 12 17:08:23 integro ntpd[3274]: receive: Unexpected origin timestamp 0xed3808f6.cbf6e838 does not match aorg 0000000000.00000000 from server@85.121.122.62 xmt 0xed3808f7.d62dfedc
Feb 12 17:08:23 integro ntpd[3274]: receive: Unexpected origin timestamp 0xed3808f6.cc0cb76d does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xed3808f7.d733f464
Feb 12 17:08:23 integro ntpd[3274]: receive: Unexpected origin timestamp 0xed3808f6.cc01bbca does not match aorg 0000000000.00000000 from server@129.250.35.251 xmt 0xed3808f7.d67618e8
Feb 12 17:08:23 integro ntpd[3274]: receive: Unexpected origin timestamp 0xed3808f6.cc08597a does not match aorg 0000000000.00000000 from server@172.237.20.5 xmt 0xed3808f7.d6a32e70
Feb 12 17:08:23 integro ntpd[3274]: receive: Unexpected origin timestamp 0xed3808f6.cc0a7ca7 does not match aorg 0000000000.00000000 from server@129.250.35.250 xmt 0xed3808f7.d5e05161
Feb 12 17:08:23 integro systemd[1]: Starting Daily apt download activities...
Feb 12 17:08:23 integro ntpd[3274]: receive: Unexpected origin timestamp 0xed3808f6.cbff20e9 does not match aorg 0000000000.00000000 from server@163.44.119.85 xmt 0xed3808f7.d8243d13
Feb 12 17:08:23 integro ntpd[3274]: receive: Unexpected origin timestamp 0xed3808f6.cc0ee60d does not match aorg 0000000000.00000000 from server@45.88.43.100 xmt 0xed3808f7.da2ac032
Feb 12 17:08:23 integro volumio[3099]: verbose: New Socket.io Connection to 100.64.1.58:3000 from 100.64.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1
Feb 12 17:08:23 integro volumio[3099]: verbose: New Socket.io Connection to 100.64.1.58:3000 from 100.64.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2
Feb 12 17:08:23 integro volumio[3099]: verbose: New Socket.io Connection to 100.64.1.58:3000 from 100.64.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3
Feb 12 17:08:23 integro volumio[3099]: verbose: New Socket.io Connection to 100.64.1.58:3000 from 100.64.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4
Feb 12 17:08:23 integro volumio-remote-updater[2819]: [2026-02-12 17:08:23] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770883698 101
Feb 12 17:08:23 integro volumio[3099]: 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: 5
Feb 12 17:08:24 integro volumio[3099]: verbose: New Socket.io Connection to 100.64.1.58:3000 from 100.64.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Feb 12 17:08:24 integro volumio[3099]: Unable to parse:
Feb 12 17:08:24 integro volumio[3099]: Simple mixer control 'Audio hdmi-out mute',0
Feb 12 17:08:24 integro volumio[3099]: Capabilities: pswitch pswitch-joined
Feb 12 17:08:24 integro volumio[3099]: Playback channels: Mono
Feb 12 17:08:24 integro volumio[3099]: Mono: Playback [on]
Feb 12 17:08:24 integro volumio[3099]: info: VolumeController:: Volume=undefined Mute =false
Feb 12 17:08:24 integro volumio[3099]: info: CoreStateMachine::pushState
Feb 12 17:08:24 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::volumioPushState
Feb 12 17:08:24 integro volumio[3099]: info: CoreStateMachine::updateTrackBlock
Feb 12 17:08:24 integro volumio[3099]: info: CorePlayQueue::getTrackBlock
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::volumioRetrievevolume
Feb 12 17:08:24 integro volumio[3099]: Unable to parse:
Feb 12 17:08:24 integro volumio[3099]: Simple mixer control 'Audio hdmi-out mute',0
Feb 12 17:08:24 integro volumio[3099]: Capabilities: pswitch pswitch-joined
Feb 12 17:08:24 integro volumio[3099]: Playback channels: Mono
Feb 12 17:08:24 integro volumio[3099]: Mono: Playback [on]
Feb 12 17:08:24 integro volumio[3099]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
Feb 12 17:08:24 integro volumio[3099]: info: Reloading queue from file
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Feb 12 17:08:24 integro volumio[3099]: info: CoreStateMachine::setRepeat false single undefined
Feb 12 17:08:24 integro volumio[3099]: info: CoreStateMachine::pushState
Feb 12 17:08:24 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::volumioPushState
Feb 12 17:08:24 integro volumio[3099]: info: CoreStateMachine::setRandom false
Feb 12 17:08:24 integro volumio[3099]: info: CoreStateMachine::pushState
Feb 12 17:08:24 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::volumioPushState
Feb 12 17:08:24 integro volumio[3099]: Unable to parse:
Feb 12 17:08:24 integro volumio[3099]: Simple mixer control 'Audio hdmi-out mute',0
Feb 12 17:08:24 integro volumio[3099]: Capabilities: pswitch pswitch-joined
Feb 12 17:08:24 integro volumio[3099]: Playback channels: Mono
Feb 12 17:08:24 integro volumio[3099]: Mono: Playback [on]
Feb 12 17:08:24 integro volumio[3099]: info: VolumeController:: Volume=undefined Mute =false
Feb 12 17:08:24 integro volumio[3099]: info: CoreStateMachine::pushState
Feb 12 17:08:24 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::volumioPushState
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:24 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:24 integro volumio[3099]: info: Discovery: adding 7c18e49f-20a4-4166-830a-4a248068604b
Feb 12 17:08:24 integro volumio[3099]: info: Discovery: Found device Integro
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:24 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:24 integro sudo[3524]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Feb 12 17:08:24 integro sudo[3524]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:24 integro volumio[3099]: info: Asound.conf file unchanged, so no further update is needed
Feb 12 17:08:24 integro volumio[3099]: info: Output device has changed, restarting MPD
Feb 12 17:08:24 integro systemd[1]: Started UPnP Renderer front-end to MPD.
Feb 12 17:08:24 integro sudo[3524]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:24 integro sudo[3528]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 12 17:08:24 integro sudo[3528]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:24 integro sudo[3528]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:24 integro volumio[3099]: info: ___________ START PLUGINS ___________
Feb 12 17:08:24 integro sudo[3532]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 12 17:08:24 integro sudo[3532]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:24 integro volumio[3099]: info: ControllerMpd::onStart: Initializing MPD
Feb 12 17:08:24 integro volumio[3099]: info: Creating MPD Configuration file
Feb 12 17:08:24 integro sudo[3535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service
Feb 12 17:08:24 integro sudo[3535]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:24 integro systemd[1]: Listening on mpd.socket.
Feb 12 17:08:24 integro systemd[1]: Starting Music Player Daemon...
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 12 17:08:24 integro volumio[3099]: info: [1770883704563] CoreMusicLibrary::Adding element DLNAサーバー
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 12 17:08:24 integro sudo[3540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 12 17:08:24 integro sudo[3540]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:24 integro systemd[1]: Started Volumio5 Onboarding Server.
Feb 12 17:08:24 integro volumio[3099]: info: UPNP Browser: Client initialized successfully
Feb 12 17:08:24 integro sudo[3535]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:24 integro sudo[3541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 12 17:08:24 integro sudo[3541]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:24 integro sudo[3540]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 12 17:08:24 integro volumio[3099]: info: [1770883704645] CoreMusicLibrary::Adding element Last_100
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 12 17:08:24 integro volumio[3099]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect
Feb 12 17:08:24 integro systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Feb 12 17:08:24 integro systemd[1]: mpd.service: Succeeded.
Feb 12 17:08:24 integro systemd[1]: Stopped Music Player Daemon.
Feb 12 17:08:24 integro systemd[1]: Starting Music Player Daemon...
Feb 12 17:08:24 integro volumio[3099]: info: QobuzConnect: Starting Qobuz Connect socket and service
Feb 12 17:08:24 integro volumio[3099]: info: Streaming services startup
Feb 12 17:08:24 integro volumio[3099]: info: Starting Streaming Daemon
Feb 12 17:08:24 integro sudo[3550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Feb 12 17:08:24 integro sudo[3550]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:24 integro sudo[3550]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:24 integro sudo[3553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Feb 12 17:08:24 integro sudo[3553]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 12 17:08:24 integro volumio[3099]: info: [1770883704818] CoreMusicLibrary::Adding element Webradio
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 12 17:08:24 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 12 17:08:24 integro volumio[3099]: info: Initializing BBC Radios
Feb 12 17:08:24 integro sudo[3553]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:24 integro sudo[3560]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Feb 12 17:08:24 integro sudo[3560]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:24 integro sudo[3548]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 12 17:08:24 integro sudo[3548]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:24 integro systemd[1]: Started Volumio Qobuz Connect Service.
Feb 12 17:08:24 integro sudo[3560]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:24 integro sudo[3548]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Feb 12 17:08:24 integro sudo[3548]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:25 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 12 17:08:25 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 12 17:08:25 integro volumio[3099]: info: Creating Spotify config file
Feb 12 17:08:25 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:25 integro volumio[3099]: info: Starting CEC Infrastructure
Feb 12 17:08:25 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 12 17:08:25 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections
Feb 12 17:08:25 integro volumio[3099]: info: Additional UI Settings Added for plugin music_service/hdmi_arc
Feb 12 17:08:25 integro volumio[3099]: error: Hi Res Audio Failed Login: Missing Login Data
Feb 12 17:08:25 integro volumio[3099]: info: Adding HIGHRESAUDIO REST API Endpoints
Feb 12 17:08:25 integro volumio[3099]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Feb 12 17:08:25 integro volumio[3099]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Feb 12 17:08:25 integro volumio[3099]: info: Initializing Serial Communication on port /dev/ttyS3
Feb 12 17:08:25 integro volumio5-onboarding[3542]: time=2026-02-12T17:08:25.256+09:00 level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z
Feb 12 17:08:25 integro kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600
Feb 12 17:08:25 integro kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600
Feb 12 17:08:25 integro kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200
Feb 12 17:08:25 integro volumio[3099]: info: Touch Event Listener Process Starting
Feb 12 17:08:25 integro sudo[3585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root
Feb 12 17:08:25 integro sudo[3585]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:25 integro sudo[3585]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:25 integro sudo[3591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0
Feb 12 17:08:25 integro sudo[3591]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:25 integro sudo[3591]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:25 integro sudo[3596]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0
Feb 12 17:08:25 integro sudo[3596]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:25 integro sudo[3596]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:25 integro sudo[3602]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1
Feb 12 17:08:25 integro sudo[3602]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:25 integro sudo[3602]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:25 integro sudo[3608]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1
Feb 12 17:08:25 integro sudo[3608]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:25 integro sudo[3608]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:25 integro volumio[3099]: info: MP1 Muting HDMI Output
Feb 12 17:08:25 integro volumio[3099]: info: Apply VIM3L Onboard LEDs Settings
Feb 12 17:08:25 integro volumio[3099]: info: Turning On Onboard LEDs
Feb 12 17:08:25 integro volumio[3099]: info: Loading i18n strings for locale ja
Feb 12 17:08:25 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Feb 12 17:08:25 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:25 integro volumio[3099]: info: FusionDsp - mixtype--------------------- Hardware
Feb 12 17:08:25 integro volumio[3099]: info: Volumio Calling Home
Feb 12 17:08:25 integro sudo[3618]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger
Feb 12 17:08:25 integro sudo[3618]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:25 integro sudo[3618]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:25 integro sudo[3625]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger
Feb 12 17:08:25 integro sudo[3625]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:25 integro volumio[3099]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections
Feb 12 17:08:25 integro sudo[3625]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:25 integro volumio[3099]: info: Preparing to generate the ALSA configuration file
Feb 12 17:08:25 integro volumio[3099]: info: Stopping AccessToken refresher cron for QOBUZ
Feb 12 17:08:25 integro volumio[3099]: info: AccessToken refresher cron started for QOBUZ
Feb 12 17:08:25 integro volumio[3099]: info: Adding TIDAL REST API Endpoints
Feb 12 17:08:25 integro volumio[3099]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
Feb 12 17:08:25 integro volumio[3099]: info: Adding QOBUZ REST API Endpoints
Feb 12 17:08:25 integro volumio[3099]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
Feb 12 17:08:26 integro volumio[3099]: info: Discovery: adding fc5805da-fd3a-4bf4-9352-ef594b33409a
Feb 12 17:08:26 integro volumio[3099]: info: Discovery: Found device Rivo+
Feb 12 17:08:26 integro volumio[3099]: info: Discovery: Connecting to remote: 100.64.1.40
Feb 12 17:08:26 integro volumio[3099]: info: Serial port opened successfully
Feb 12 17:08:26 integro volumio[3099]: info: Sending serial start messages
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: Reporting MCU Network Status: 0
Feb 12 17:08:26 integro volumio[3099]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Feb 12 17:08:26 integro volumio[3099]: info: Reading ALSA contributions from plugins.
Feb 12 17:08:26 integro systemd[1]: apt-daily.service: Succeeded.
Feb 12 17:08:26 integro systemd[1]: Started Daily apt download activities.
Feb 12 17:08:26 integro volumio[3099]: info: Touch Event Listener Process Closed
Feb 12 17:08:26 integro volumio[3099]: error: Cannot start Volumio Streaming Daemon
Feb 12 17:08:26 integro volumio[3099]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Feb 12 17:08:26 integro volumio[3099]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Feb 12 17:08:26 integro volumio[3099]: info: MPD Permissions set
Feb 12 17:08:26 integro volumio[3099]: info: MPD Permissions set
Feb 12 17:08:26 integro volumio[3099]: info: Upmpdcli Daemon Started
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride
Feb 12 17:08:26 integro volumio[3099]: info: Setting Device Volume Override
Feb 12 17:08:26 integro volumio[3099]: info: Applying Volume Override
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Feb 12 17:08:26 integro volumio[3099]: info: Updating Volume Controller Parameters: Device: 0,0 Name: I2S Mixer: Audio hdmi-out mute Max Vol: 40 Vol Curve; logarithmic Vol Steps: 1
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Feb 12 17:08:26 integro volumio[3099]: info: Enabling external Volume Control
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: inputs , updateVolumeSettings
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: inputs , retrievevolume
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreStateMachine::pushState
Feb 12 17:08:26 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::volumioPushState
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:26 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:26 integro volumio[3099]: info: Discovery: A device disappeared from network
Feb 12 17:08:26 integro volumio[3099]: verbose: New Socket.io Connection to 100.64.1.58:3000 from 100.64.1.40 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Feb 12 17:08:26 integro volumio[3099]: info: Executing endpoint qc_getconfig
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Feb 12 17:08:26 integro qobuz-connect[3569]: 20260212 17:08:26.350 [3569.3569] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Feb 12 17:08:26 integro volumio[3099]: 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: 8
Feb 12 17:08:26 integro volumio[3099]: info: Spotify config file written
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo
Feb 12 17:08:26 integro volumio[3099]: info: Setting Additional System Software info: Hardware Revision: 1.3
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion
Feb 12 17:08:26 integro volumio[3099]: info: Setting HW Firmware info: undefined
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion
Feb 12 17:08:26 integro volumio[3099]: info: Setting HW Version info: 1.3
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo
Feb 12 17:08:26 integro volumio[3099]: info: Setting Additional System Software info: Hardware Revision: 1.3, Firmware Version: 0.7.3
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion
Feb 12 17:08:26 integro volumio[3099]: info: Setting HW Firmware info: 0.7.3
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion
Feb 12 17:08:26 integro volumio[3099]: info: Setting HW Version info: 1.3
Feb 12 17:08:26 integro volumio[3099]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Feb 12 17:08:26 integro volumio[3099]: info: MCU Signalled Headphone Mode Disabled
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState
Feb 12 17:08:26 integro volumio[3099]: info: MCU Signalled Sleep Mode Disabled
Feb 12 17:08:26 integro sudo[3653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Feb 12 17:08:26 integro sudo[3653]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:26 integro volumio[3099]: info: Enabling Advanced system settings configuration
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections
Feb 12 17:08:26 integro volumio[3099]: info: Additional UI Settings Added for plugin music_service/inputs
Feb 12 17:08:26 integro volumio[3099]: info: MCU Signalled Auto Boot Mode On Power Disabled
Feb 12 17:08:26 integro qobuz-connect[3569]: 20260212 17:08:26.475 [3569.3569] INFO VolumeManager: [0xabdec240]: Setting new playback volume: 75
Feb 12 17:08:26 integro qobuz-connect[3569]: 20260212 17:08:26.475 [3569.3569] INFO VolumeManager: [0xabdec240]: Setting new mute state: 0
Feb 12 17:08:26 integro qobuz-connect[3569]: 20260212 17:08:26.476 [3569.3569] INFO QobuzConnect: [0xabdecc10]: Client initialized!
Feb 12 17:08:26 integro qobuz-connect[3569]: 20260212 17:08:26.477 [3569.3569] INFO SampleApp: Starting Avahi advertising, name: Integro, service name: _qobuz-connect._tcp
Feb 12 17:08:26 integro sudo[3656]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on
Feb 12 17:08:26 integro sudo[3656]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:26 integro volumio[3099]: info: Discovery: A device disappeared from network
Feb 12 17:08:26 integro volumio[3099]: info: Discovery: Device integro disappeared from network
Feb 12 17:08:26 integro qobuz-connect[3569]: 20260212 17:08:26.500 [3569.3569] INFO LocalConfigManager: [0xabdebb20]: Starting Local Configuration server
Feb 12 17:08:26 integro qobuz-connect[3569]: 20260212 17:08:26.500 [3569.3569] INFO SampleApp: Starting Local configuration server
Feb 12 17:08:26 integro qobuz-connect[3569]: 20260212 17:08:26.501 [3569.3569] INFO SampleApp: Connected to UNIX socket client 0xabde1ed8
Feb 12 17:08:26 integro qobuz-connect[3569]: 20260212 17:08:26.501 [3569.3569] INFO SampleApp: Playback volume changed: 75
Feb 12 17:08:26 integro systemd[1]: Started go-librespot Daemon.
Feb 12 17:08:26 integro sudo[3653]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:26 integro sudo[3656]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:26 integro go-librespot[3658]: go-librespot daemon starting...
Feb 12 17:08:26 integro volumio[3099]: info: Discovery: Connected to remote: 100.64.1.40
Feb 12 17:08:26 integro volumio[3099]: 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: 8
Feb 12 17:08:26 integro volumio[3099]: info: Received Get System Info
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 12 17:08:26 integro volumio[3099]: info: Discovery: Getting this device information
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:26 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 12 17:08:26 integro volumio5-onboarding[3542]: time=2026-02-12T17:08:26.621+09:00 level=INFO msg="system info for b1b7d13aed7c0e5cae19b7aaa1a63844" deviceName=Integro deviceVariant=integro deviceModel="Volumio Integro" softwareVersion=3.908
Feb 12 17:08:26 integro volumio[3099]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9
Feb 12 17:08:26 integro volumio[3099]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Feb 12 17:08:26 integro volumio[3099]: info: QobuzConnect: QOBUZ Connect daemon connected
Feb 12 17:08:26 integro volumio[3099]: info: Volumio called home
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Feb 12 17:08:26 integro go-librespot[3658]: time="2026-02-12T17:08:26+09:00" level=info msg="running go-librespot 0.6.2"
Feb 12 17:08:26 integro go-librespot[3658]: time="2026-02-12T17:08:26+09:00" level=debug msg="app state loaded"
Feb 12 17:08:26 integro go-librespot[3658]: time="2026-02-12T17:08:26+09:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: No need to fix Spotify hosts
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:26 integro volumio[3099]: error: Serial API: Failed to decode command: MAXVOL, message: 40
Feb 12 17:08:26 integro volumio[3099]: error: Serial API: Failed to decode command: MAXVOL, message: 40
Feb 12 17:08:26 integro volumio[3099]: info: Received Get System Info
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 12 17:08:26 integro volumio[3099]: info: Discovery: Getting this device information
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:26 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 12 17:08:26 integro volumio[3099]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:26 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 12 17:08:26 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 12 17:08:26 integro sudo[3680]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0
Feb 12 17:08:26 integro sudo[3680]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:26 integro volumio5-onboarding[3542]: time=2026-02-12T17:08:26.928+09:00 level=INFO msg="enabling local network discovery"
Feb 12 17:08:26 integro sudo[3680]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:26 integro volumio5-onboarding[3542]: time=2026-02-12T17:08:26.943+09:00 level=INFO msg="bootstrapping state" hasInternet=true
Feb 12 17:08:27 integro volumio[3099]: info: Received Get System Info
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 12 17:08:27 integro volumio[3099]: info: Discovery: Getting this device information
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 12 17:08:27 integro volumio[3099]: info: Adding Inputs via Serial API
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 12 17:08:27 integro volumio[3099]: info: [1770883707142] CoreMusicLibrary::Adding element Inputs
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 12 17:08:27 integro volumio[3099]: info: CoreStateMachine::pushState
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioPushState
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro volumio[3099]: info: CoreStateMachine::pushState
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioPushState
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro volumio-remote-updater[2819]: No test mode
Feb 12 17:08:27 integro volumio-remote-updater[2819]: No alpha test mode
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+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]"
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+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]"
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+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]"
Feb 12 17:08:27 integro volumio[3099]: info: Discovery: adding 7c18e49f-20a4-4166-830a-4a248068604b
Feb 12 17:08:27 integro volumio[3099]: info: Discovery: Found device Integro
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=info msg="zeroconf server listening on port 44041"
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::servicePushState
Feb 12 17:08:27 integro volumio[3099]: info: CoreStateMachine::pushState
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioPushState
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro volumio[3099]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received inputs
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumiosetSourceActiveno-source
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro volumio[3099]: info: Asound.conf file unchanged, so no further update is needed
Feb 12 17:08:27 integro volumio[3099]: info: Output device has changed, restarting MPD
Feb 12 17:08:27 integro volumio[3099]: info: QobuzConnect: setDeactiveState invoked
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=debug msg="obtained new client token: AAC1gciXH6TVk4yB5pqy8iAFG70nAZPZ4p6UGtbQ28oD2ErTPM79QWJVzW02w47eZeJISsEk0HXjRfwZC/pj/uNW9niOW9YNmCP5nvKLZ/TySJCu20AdL2yPzaxcEMU9JfHJ+RitnEvcLUtIZ1teDKZNzWPIJzrJwDaBGo20jC97hMZiH6W1Ll+lYdplki4RzBJxM8Z9z7hyMQ4O3wsUm4jGyuVYOvUm8EmRF3Xz8HatEiWJD0hs/3eh+w=="
Feb 12 17:08:27 integro sudo[3685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 12 17:08:27 integro sudo[3685]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:27 integro sudo[3685]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:27 integro sudo[3687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 12 17:08:27 integro sudo[3687]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:27 integro volumio[3099]: info: New Spotify access tokenBQBjNP4eHb...
Feb 12 17:08:27 integro volumio[3099]: info: Spotify credentials grant success - running version from March 24, 2019
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=debug msg="connected to ap-gae2.spotify.com:4070"
Feb 12 17:08:27 integro systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Feb 12 17:08:27 integro systemd[1]: mpd.service: Succeeded.
Feb 12 17:08:27 integro sudo[3694]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Feb 12 17:08:27 integro systemd[1]: Stopped Music Player Daemon.
Feb 12 17:08:27 integro sudo[3694]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:27 integro systemd[1]: Starting Music Player Daemon...
Feb 12 17:08:27 integro sudo[3694]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:27 integro sudo[3698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Feb 12 17:08:27 integro sudo[3698]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=debug msg="completed keyexchange"
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=debug msg="completed challenge"
Feb 12 17:08:27 integro volumio[3099]: info: MPD Permissions set
Feb 12 17:08:27 integro volumio[3099]: info: CoreStateMachine::pushState
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioPushState
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro qobuz-connect[3569]: 20260212 17:08:27.565 [3569.3569] INFO SampleApp: Stopping Local configuration server
Feb 12 17:08:27 integro systemd[1]: Stopping Volumio Qobuz Connect Service...
Feb 12 17:08:27 integro qobuz-connect[3569]: 20260212 17:08:27.575 [3569.3569] INFO SampleApp: shat down connection on UNIX socket
Feb 12 17:08:27 integro systemd[1]: qobuz-connect.service: Succeeded.
Feb 12 17:08:27 integro systemd[1]: Stopped Volumio Qobuz Connect Service.
Feb 12 17:08:27 integro volumio[3099]: info: CoreStateMachine::pushState
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioPushState
Feb 12 17:08:27 integro systemd[1]: Started Volumio Qobuz Connect Service.
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:27 integro sudo[3698]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=info msg="authenticated AP" username="hc*********************ni"
Feb 12 17:08:27 integro sudo[3697]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 12 17:08:27 integro sudo[3697]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:27 integro volumio[3099]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Feb 12 17:08:27 integro volumio[3099]: info: QobuzConnect: setDeactiveState invoked
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::volumioGetState
Feb 12 17:08:27 integro volumio[3099]: info: CorePlayQueue::getTrack 0
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:27 integro sudo[3697]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Feb 12 17:08:27 integro sudo[3697]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:27 integro volumio[3099]: info: Discovery: adding fc5805da-fd3a-4bf4-9352-ef594b33409a
Feb 12 17:08:27 integro volumio[3099]: info: Discovery: Found device Rivo+
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=info msg="authenticated Login5" username="hc*********************ni"
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=debug msg="initializing zeroconf session" username="hc*********************ni"
Feb 12 17:08:27 integro volumio[3099]: info: camilladsp service started and running in background, instance 1
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 17:08:27 integro volumio[3099]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Feb 12 17:08:27 integro volumio[3099]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Feb 12 17:08:27 integro volumio[3099]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Feb 12 17:08:27 integro volumio[3099]: info: FusionDsp loaded
Feb 12 17:08:27 integro volumio[3099]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 12 17:08:27 integro sudo[3722]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Feb 12 17:08:27 integro sudo[3722]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 17:08:27 integro volumio[3099]: info: FusionDsp - Reporting Fusion DSP Enabled
Feb 12 17:08:27 integro volumio[3099]: info: Adding Signal Path Element [object Object]
Feb 12 17:08:27 integro volumio[3099]: info: Adding fusiondspeq DSP Signal Path Element
Feb 12 17:08:27 integro volumio[3099]: info: FusionDsp - ---- installed callbackRead
Feb 12 17:08:27 integro volumio[3099]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 12 17:08:27 integro volumio[3099]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Feb 12 17:08:27 integro volumio[3099]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19)
Feb 12 17:08:27 integro volumio[3099]: at onErrorNT (internal/child_process.js:472:16)
Feb 12 17:08:27 integro volumio[3099]: at processTicksAndRejections (internal/process/task_queues.js:82:21)
Feb 12 17:08:27 integro volumio[3099]: at runNextTicks (internal/process/task_queues.js:64:3)
Feb 12 17:08:27 integro volumio[3099]: at listOnTimeout (internal/timers.js:526:9)
Feb 12 17:08:27 integro volumio[3099]: at processTimers (internal/timers.js:500:7) {
Feb 12 17:08:27 integro volumio[3099]: errno: -2,
Feb 12 17:08:27 integro volumio[3099]: code: 'ENOENT',
Feb 12 17:08:27 integro volumio[3099]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Feb 12 17:08:27 integro volumio[3099]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Feb 12 17:08:27 integro volumio[3099]: spawnargs: [
Feb 12 17:08:27 integro volumio[3099]: '-p',
Feb 12 17:08:27 integro volumio[3099]: 9876,
Feb 12 17:08:27 integro volumio[3099]: '-o',
Feb 12 17:08:27 integro volumio[3099]: '/tmp/camilladsp.log',
Feb 12 17:08:27 integro volumio[3099]: '-l',
Feb 12 17:08:27 integro volumio[3099]: 'warn',
Feb 12 17:08:27 integro volumio[3099]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Feb 12 17:08:27 integro volumio[3099]: ]
Feb 12 17:08:27 integro volumio[3099]: }
Feb 12 17:08:27 integro volumio[3099]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 12 17:08:27 integro systemd[1]: Started FusionDsp Daemon.
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=debug msg="dealer connection opened"
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=trace msg="starting accesspoint recv loop"
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=trace msg="starting dealer recv loop"
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=trace msg="received accesspoint ping"
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336"
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2"
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=debug msg="received connection id: OTQ1OTRlMmMtMDU3...OTVEQjQ5QUE2Mw=="
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17"
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0"
Feb 12 17:08:27 integro go-librespot[3658]: time="2026-02-12T17:08:27+09:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481"
Feb 12 17:08:27 integro sudo[3722]: pam_unix(sudo:session): session closed for user root
Feb 12 17:08:28 integro go-librespot[3658]: time="2026-02-12T17:08:28+09:00" level=trace msg="received accesspoint pong ack"
Feb 12 17:08:28 integro go-librespot[3658]: time="2026-02-12T17:08:28+09:00" level=debug msg="put connect state because NEW_DEVICE"
Feb 12 17:08:28 integro sudo[3734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-12 17:07
Feb 12 17:08:28 integro sudo[3734]: 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="e9612ec5034fb2e958508aaefbca2962fd6f6654"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="integro"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 02:44:38 PM CET"
VOLUMIO_VERSION="3.908"
VOLUMIO_HARDWARE="mp1"
VOLUMIO_DEVICENAME="Volumio MP1"
VOLUMIO_VENDOR_MODEL="Volumio Integro"
VOLUMIO_VENDOR="Volumio"
VOLUMIO_MODEL="Integro"
VOLUMIO_HASH="428ce38f6e9822d6187829bdc3b5dd9d"