-- Logs begin at Wed 2026-02-11 19:00:17 JST, end at Thu 2026-02-12 18:01:08 JST. --
Feb 12 18:00:56 integro systemd-timedated[3367]: Changed local time to Thu Feb 12 18:00:56 2026
Feb 12 18:00:56 integro sudo[3365]: pam_unix(sudo:session): session closed for user root
Feb 12 18:00:56 integro volumio-time-update[2833]: volumio-time-update-util: System time updated successfully.
Feb 12 18:00:56 integro systemd[1]: Starting Daily apt download activities...
Feb 12 18:00:56 integro systemd[1]: Starting Daily man-db regeneration...
Feb 12 18:00:56 integro systemd[1]: Started Volumio Time Update Utility.
Feb 12 18:00:56 integro systemd[1]: Reached target Multi-User System.
Feb 12 18:00:56 integro systemd[1]: Reached target Graphical Interface.
Feb 12 18:00:56 integro systemd[1]: Starting Update UTMP about System Runlevel Changes...
Feb 12 18:00:56 integro systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Feb 12 18:00:56 integro systemd[1]: Started Update UTMP about System Runlevel Changes.
Feb 12 18:00:56 integro ntpd[3307]: Soliciting pool server 129.250.35.250
Feb 12 18:00:56 integro ntpd[3307]: Soliciting pool server 160.16.113.133
Feb 12 18:00:56 integro volumio[3097]: info: Applying required configuration parameters for plugin hi_res_audio
Feb 12 18:00:56 integro volumio[3097]: info: Loading plugin "inputs"...
Feb 12 18:00:56 integro ntpd[3307]: Soliciting pool server 167.179.119.205
Feb 12 18:00:56 integro systemd[1]: man-db.service: Succeeded.
Feb 12 18:00:56 integro systemd[1]: Started Daily man-db regeneration.
Feb 12 18:00:57 integro volumio[3097]: info: Loading plugin "qobuz"...
Feb 12 18:00:57 integro ntpd[3307]: Soliciting pool server 162.159.200.1
Feb 12 18:00:57 integro ntpd[3307]: Soliciting pool server 85.121.50.82
Feb 12 18:00:58 integro volumio-remote-updater[2825]: [2026-02-12 18:00:58] [connect] Successful connection
Feb 12 18:00:58 integro systemd[1]: apt-daily.service: Succeeded.
Feb 12 18:00:58 integro systemd[1]: Started Daily apt download activities.
Feb 12 18:00:58 integro systemd[1]: Starting Daily apt upgrade and clean activities...
Feb 12 18:00:58 integro ntpd[3307]: Soliciting pool server 2400:8902::f03c:95ff:feac:c71c
Feb 12 18:00:59 integro volumio[3097]: info: Plugin smart_inputs is not enabled
Feb 12 18:00:59 integro volumio[3097]: info: Loading plugin "tidal"...
Feb 12 18:01:00 integro systemd[1]: apt-daily-upgrade.service: Succeeded.
Feb 12 18:01:00 integro systemd[1]: Started Daily apt upgrade and clean activities.
Feb 12 18:01:00 integro systemd[1]: Startup finished in 12.927s (kernel) + 24.898s (userspace) = 37.826s.
Feb 12 18:01:00 integro volumio[3097]: info: Loading plugin "integrocontrol"...
Feb 12 18:01:00 integro volumio[3097]: info: Adding this device properties
Feb 12 18:01:00 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , setThisDeviceVolumioProperties
Feb 12 18:01:00 integro volumio[3097]: info: Setting Additional Device Volumio Properties: [object Object]
Feb 12 18:01:00 integro volumio[3097]: info: Loading plugin "updater_comm"...
Feb 12 18:01:01 integro volumio[3097]: info: Plugin mpdemulation is not enabled
Feb 12 18:01:01 integro volumio[3097]: info: Loading plugin "rest_api"...
Feb 12 18:01:01 integro volumio[3097]: info: Loading plugin "websocket"...
Feb 12 18:01:01 integro volumio[3097]: info: Starting Socket.io Server version 2.3.0
Feb 12 18:01:01 integro volumio[3097]: info: Loading plugin "fusiondsp"...
Feb 12 18:01:01 integro volumio[3097]: info: Applying required configuration parameters for plugin fusiondsp
Feb 12 18:01:01 integro volumio[3097]: info: Loading i18n strings for locale ja
Feb 12 18:01:01 integro volumio[3097]: Updating browse sources language
Feb 12 18:01:01 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 12 18:01:02 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 12 18:01:02 integro volumio[3097]: info: CoreCommandRouter::initPlayerControls
Feb 12 18:01:02 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:02 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:02 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:02 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:02 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:02 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:02 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:02 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:02 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 12 18:01:02 integro volumio[3097]: Express server listening on port 3000
Feb 12 18:01:02 integro volumio[3097]: [Metrics] WebUI: 18s 448.74ms
Feb 12 18:01:02 integro volumio[3097]: info: CoreStateMachine::resetVolumioState
Feb 12 18:01:02 integro volumio[3097]: info: CoreStateMachine::getcurrentVolume
Feb 12 18:01:02 integro volumio[3097]: info: CoreCommandRouter::volumioRetrievevolume
Feb 12 18:01:02 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 12 18:01:02 integro sudo[3521]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Feb 12 18:01:02 integro sudo[3521]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:02 integro sudo[3521]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:02 integro sudo[3523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Feb 12 18:01:02 integro volumio[3097]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt'
Feb 12 18:01:02 integro sudo[3523]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:02 integro volumio[3097]: info: Completed loading Core Plugins
Feb 12 18:01:02 integro volumio[3097]: info: Preparing to generate the ALSA configuration file
Feb 12 18:01:02 integro sudo[3523]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:02 integro volumio[3097]: info: Volumio Network Manager: Network status updated: 0
Feb 12 18:01:02 integro volumio[3097]: Unable to parse:
Feb 12 18:01:02 integro volumio[3097]: Simple mixer control 'Audio hdmi-out mute',0
Feb 12 18:01:02 integro volumio[3097]: Capabilities: pswitch pswitch-joined
Feb 12 18:01:02 integro volumio[3097]: Playback channels: Mono
Feb 12 18:01:02 integro volumio[3097]: Mono: Playback [on]
Feb 12 18:01:02 integro volumio[3097]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
Feb 12 18:01:02 integro volumio[3097]: info: Cannot mount NAS contents at system boot, trial number 1 ,retrying in 5 seconds
Feb 12 18:01:02 integro volumio[3097]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision
Feb 12 18:01:02 integro volumio[3097]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Feb 12 18:01:02 integro volumio[3097]: info: Reading ALSA contributions from plugins.
Feb 12 18:01:03 integro ntpd[3307]: receive: Unexpected origin timestamp 0xed38154e.71ec51fe does not match aorg 0000000000.00000000 from server@172.237.20.5 xmt 0xed38154f.cea847d2
Feb 12 18:01:03 integro ntpd[3307]: receive: Unexpected origin timestamp 0xed38154e.71d280eb does not match aorg 0000000000.00000000 from server@85.121.50.82 xmt 0xed38154f.cebc7040
Feb 12 18:01:03 integro ntpd[3307]: receive: Unexpected origin timestamp 0xed38154e.71ea30ec does not match aorg 0000000000.00000000 from server@162.159.200.123 xmt 0xed38154f.cf49f2c8
Feb 12 18:01:03 integro ntpd[3307]: receive: Unexpected origin timestamp 0xed38154e.71e37e06 does not match aorg 0000000000.00000000 from server@129.250.35.251 xmt 0xed38154f.cea75353
Feb 12 18:01:03 integro ntpd[3307]: receive: Unexpected origin timestamp 0xed38154e.71db7053 does not match aorg 0000000000.00000000 from server@162.159.200.1 xmt 0xed38154f.cef1e46a
Feb 12 18:01:03 integro ntpd[3307]: receive: Unexpected origin timestamp 0xed38154e.71dea790 does not match aorg 0000000000.00000000 from server@160.16.113.133 xmt 0xed38154f.ced24a2a
Feb 12 18:01:03 integro ntpd[3307]: receive: Unexpected origin timestamp 0xed38154e.71e1289c does not match aorg 0000000000.00000000 from server@163.44.119.85 xmt 0xed38154f.d0204308
Feb 12 18:01:03 integro ntpd[3307]: receive: Unexpected origin timestamp 0xed38154e.71e800c9 does not match aorg 0000000000.00000000 from server@110.4.129.114 xmt 0xed38154f.d0da7b82
Feb 12 18:01:03 integro volumio[3097]: 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 18:01:03 integro volumio[3097]: 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 18:01:03 integro volumio-remote-updater[2825]: [2026-02-12 18:01:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1770886858 101
Feb 12 18:01:03 integro volumio[3097]: 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
Feb 12 18:01:03 integro volumio[3097]: 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 18:01:03 integro volumio[3097]: Unable to parse:
Feb 12 18:01:03 integro volumio[3097]: Simple mixer control 'Audio hdmi-out mute',0
Feb 12 18:01:03 integro volumio[3097]: Capabilities: pswitch pswitch-joined
Feb 12 18:01:03 integro volumio[3097]: Playback channels: Mono
Feb 12 18:01:03 integro volumio[3097]: Mono: Playback [on]
Feb 12 18:01:03 integro volumio[3097]: info: VolumeController:: Volume=undefined Mute =false
Feb 12 18:01:03 integro volumio[3097]: info: CoreStateMachine::pushState
Feb 12 18:01:03 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:03 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 12 18:01:03 integro volumio[3097]: info: CoreCommandRouter::volumioPushState
Feb 12 18:01:03 integro volumio[3097]: info: CoreStateMachine::updateTrackBlock
Feb 12 18:01:03 integro volumio[3097]: info: CorePlayQueue::getTrackBlock
Feb 12 18:01:03 integro volumio[3097]: info: CoreCommandRouter::volumioRetrievevolume
Feb 12 18:01:04 integro volumio[3097]: info: Reloading queue from file
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket
Feb 12 18:01:04 integro volumio[3097]: Unable to parse:
Feb 12 18:01:04 integro volumio[3097]: Simple mixer control 'Audio hdmi-out mute',0
Feb 12 18:01:04 integro volumio[3097]: Capabilities: pswitch pswitch-joined
Feb 12 18:01:04 integro volumio[3097]: Playback channels: Mono
Feb 12 18:01:04 integro volumio[3097]: Mono: Playback [on]
Feb 12 18:01:04 integro volumio[3097]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: failed to parse output
Feb 12 18:01:04 integro volumio[3097]: info: CoreStateMachine::setRepeat false single undefined
Feb 12 18:01:04 integro volumio[3097]: info: CoreStateMachine::pushState
Feb 12 18:01:04 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::volumioPushState
Feb 12 18:01:04 integro volumio[3097]: info: CoreStateMachine::setRandom false
Feb 12 18:01:04 integro volumio[3097]: info: CoreStateMachine::pushState
Feb 12 18:01:04 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::volumioPushState
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:04 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:04 integro volumio[3097]: Unable to parse:
Feb 12 18:01:04 integro volumio[3097]: Simple mixer control 'Audio hdmi-out mute',0
Feb 12 18:01:04 integro volumio[3097]: Capabilities: pswitch pswitch-joined
Feb 12 18:01:04 integro volumio[3097]: Playback channels: Mono
Feb 12 18:01:04 integro volumio[3097]: Mono: Playback [on]
Feb 12 18:01:04 integro volumio[3097]: info: VolumeController:: Volume=undefined Mute =false
Feb 12 18:01:04 integro volumio[3097]: info: CoreStateMachine::pushState
Feb 12 18:01:04 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::volumioPushState
Feb 12 18:01:04 integro volumio[3097]: info: Discovery: adding 7c18e49f-20a4-4166-830a-4a248068604b
Feb 12 18:01:04 integro volumio[3097]: info: Discovery: Found device Integro
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:04 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:04 integro sudo[3538]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Feb 12 18:01:04 integro sudo[3538]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:04 integro volumio[3097]: info: Discovery: adding fc5805da-fd3a-4bf4-9352-ef594b33409a
Feb 12 18:01:04 integro volumio[3097]: info: Discovery: Found device Rivo+
Feb 12 18:01:04 integro systemd[1]: Started UPnP Renderer front-end to MPD.
Feb 12 18:01:04 integro sudo[3538]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:04 integro volumio[3097]: info: Discovery: Connecting to remote: 100.64.1.40
Feb 12 18:01:04 integro volumio[3097]: info: Asound.conf file unchanged, so no further update is needed
Feb 12 18:01:04 integro volumio[3097]: info: Output device has changed, restarting MPD
Feb 12 18:01:04 integro sudo[3542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 12 18:01:04 integro volumio[3097]: info: ___________ START PLUGINS ___________
Feb 12 18:01:04 integro sudo[3542]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:04 integro sudo[3542]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:04 integro sudo[3544]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 12 18:01:04 integro sudo[3544]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:04 integro volumio[3097]: info: ControllerMpd::onStart: Initializing MPD
Feb 12 18:01:04 integro volumio[3097]: info: Creating MPD Configuration file
Feb 12 18:01:04 integro systemd[1]: Listening on mpd.socket.
Feb 12 18:01:04 integro sudo[3549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio5-onboarding.service
Feb 12 18:01:04 integro systemd[1]: Starting Music Player Daemon...
Feb 12 18:01:04 integro sudo[3549]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:04 integro sudo[3553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Feb 12 18:01:04 integro sudo[3553]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 12 18:01:04 integro volumio[3097]: info: [1770886864473] CoreMusicLibrary::Adding element DLNAサーバー
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 12 18:01:04 integro sudo[3553]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:04 integro systemd[1]: Started Volumio5 Onboarding Server.
Feb 12 18:01:04 integro sudo[3549]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:04 integro volumio[3097]: info: UPNP Browser: Client initialized successfully
Feb 12 18:01:04 integro sudo[3556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 12 18:01:04 integro sudo[3556]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 12 18:01:04 integro volumio[3097]: info: [1770886864529] CoreMusicLibrary::Adding element Last_100
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 12 18:01:04 integro volumio[3097]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect
Feb 12 18:01:04 integro systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Feb 12 18:01:04 integro systemd[1]: mpd.service: Succeeded.
Feb 12 18:01:04 integro systemd[1]: Stopped Music Player Daemon.
Feb 12 18:01:04 integro volumio[3097]: info: QobuzConnect: Starting Qobuz Connect socket and service
Feb 12 18:01:04 integro systemd[1]: Starting Music Player Daemon...
Feb 12 18:01:04 integro volumio[3097]: info: Streaming services startup
Feb 12 18:01:04 integro volumio[3097]: info: Starting Streaming Daemon
Feb 12 18:01:04 integro sudo[3564]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Feb 12 18:01:04 integro sudo[3564]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:04 integro sudo[3564]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:04 integro sudo[3572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Feb 12 18:01:04 integro sudo[3572]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:04 integro sudo[3572]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:04 integro sudo[3575]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Feb 12 18:01:04 integro sudo[3575]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 12 18:01:04 integro volumio[3097]: info: [1770886864731] CoreMusicLibrary::Adding element Webradio
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 12 18:01:04 integro volumio[3097]: info: Initializing BBC Radios
Feb 12 18:01:04 integro sudo[3562]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 12 18:01:04 integro sudo[3562]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:04 integro sudo[3562]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Feb 12 18:01:04 integro sudo[3562]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:04 integro systemd[1]: Started Volumio Qobuz Connect Service.
Feb 12 18:01:04 integro sudo[3575]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 12 18:01:04 integro volumio[3097]: info: Creating Spotify config file
Feb 12 18:01:04 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:05 integro volumio5-onboarding[3557]: time=2026-02-12T18:01:05.007+09:00 level=INFO msg="running volumio5-device-gateway" version=30d1950e+CHANGES buildDate=2026-01-29T13:10:08Z
Feb 12 18:01:05 integro volumio[3097]: info: Starting CEC Infrastructure
Feb 12 18:01:05 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 12 18:01:05 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , addAdditionalUISections
Feb 12 18:01:05 integro volumio[3097]: info: Additional UI Settings Added for plugin music_service/hdmi_arc
Feb 12 18:01:05 integro volumio[3097]: error: Hi Res Audio Failed Login: Missing Login Data
Feb 12 18:01:05 integro volumio[3097]: info: Adding HIGHRESAUDIO REST API Endpoints
Feb 12 18:01:05 integro volumio[3097]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Feb 12 18:01:05 integro volumio[3097]: info: Adding saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio
Feb 12 18:01:05 integro volumio[3097]: info: Initializing Serial Communication on port /dev/ttyS3
Feb 12 18:01:05 integro kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 0 to 9600
Feb 12 18:01:05 integro kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 9600
Feb 12 18:01:05 integro kernel: meson_uart ffd22000.serial: ttyS3 use xtal(24M) 24000000 change 9600 to 115200
Feb 12 18:01:05 integro volumio[3097]: info: Touch Event Listener Process Starting
Feb 12 18:01:05 integro sudo[3601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xinput --test-xi2 --root
Feb 12 18:01:05 integro sudo[3601]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:05 integro sudo[3601]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:05 integro sudo[3607]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x25 0x0
Feb 12 18:01:05 integro sudo[3607]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:05 integro sudo[3607]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:05 integro sudo[3610]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x28 0x0
Feb 12 18:01:05 integro sudo[3610]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:05 integro sudo[3610]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:05 integro sudo[3613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x29 0x1
Feb 12 18:01:05 integro sudo[3613]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:05 integro sudo[3613]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:05 integro sudo[3616]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cset -f -y 4 0x18 0x33 0x1
Feb 12 18:01:05 integro sudo[3616]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:05 integro sudo[3616]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:05 integro volumio[3097]: info: MP1 Muting HDMI Output
Feb 12 18:01:05 integro volumio[3097]: info: Apply VIM3L Onboard LEDs Settings
Feb 12 18:01:05 integro volumio[3097]: info: Turning On Onboard LEDs
Feb 12 18:01:05 integro volumio[3097]: info: Loading i18n strings for locale ja
Feb 12 18:01:05 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Feb 12 18:01:05 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:05 integro volumio[3097]: info: FusionDsp - mixtype--------------------- Hardware
Feb 12 18:01:05 integro volumio[3097]: info: Volumio Calling Home
Feb 12 18:01:05 integro sudo[3622]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/sys_led/trigger
Feb 12 18:01:05 integro sudo[3622]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:05 integro sudo[3622]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:05 integro volumio[3097]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections
Feb 12 18:01:05 integro sudo[3626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/tee /sys/class/leds/red_red/trigger
Feb 12 18:01:05 integro sudo[3626]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:05 integro sudo[3626]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:05 integro volumio[3097]: info: Preparing to generate the ALSA configuration file
Feb 12 18:01:05 integro volumio[3097]: info: Stopping AccessToken refresher cron for QOBUZ
Feb 12 18:01:05 integro volumio[3097]: info: AccessToken refresher cron started for QOBUZ
Feb 12 18:01:05 integro volumio[3097]: info: Adding TIDAL REST API Endpoints
Feb 12 18:01:05 integro volumio[3097]: info: Adding getStreamUrltidal REST Endpoint for plugin: music_service/tidal
Feb 12 18:01:05 integro volumio[3097]: info: Adding QOBUZ REST API Endpoints
Feb 12 18:01:05 integro volumio[3097]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz
Feb 12 18:01:05 integro volumio[3097]: info: Upmpdcli Daemon Started
Feb 12 18:01:05 integro volumio[3097]: info: Serial port opened successfully
Feb 12 18:01:05 integro volumio[3097]: info: Sending serial start messages
Feb 12 18:01:05 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:05 integro volumio[3097]: info: Reporting MCU Network Status: 0
Feb 12 18:01:05 integro volumio[3097]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Feb 12 18:01:05 integro volumio[3097]: info: Reading ALSA contributions from plugins.
Feb 12 18:01:05 integro volumio[3097]: info: Discovery: Connected to remote: 100.64.1.40
Feb 12 18:01:05 integro volumio[3097]: info: Touch Event Listener Process Closed
Feb 12 18:01:05 integro volumio[3097]: error: Cannot start Volumio Streaming Daemon
Feb 12 18:01:05 integro volumio[3097]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Feb 12 18:01:05 integro volumio[3097]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Feb 12 18:01:05 integro volumio[3097]: info: MPD Permissions set
Feb 12 18:01:05 integro volumio[3097]: info: MPD Permissions set
Feb 12 18:01:05 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setDeviceVolumeOverride
Feb 12 18:01:05 integro volumio[3097]: info: Setting Device Volume Override
Feb 12 18:01:05 integro volumio[3097]: info: Applying Volume Override
Feb 12 18:01:05 integro volumio[3097]: info: CoreCommandRouter::volumioUpdateVolumeSettings
Feb 12 18:01:05 integro volumio[3097]: 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 18:01:05 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume
Feb 12 18:01:05 integro volumio[3097]: info: Enabling external Volume Control
Feb 12 18:01:05 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: inputs , updateVolumeSettings
Feb 12 18:01:05 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: inputs , retrievevolume
Feb 12 18:01:05 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:05 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:05 integro volumio[3097]: info: CoreStateMachine::pushState
Feb 12 18:01:05 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:05 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 12 18:01:05 integro volumio[3097]: info: CoreCommandRouter::volumioPushState
Feb 12 18:01:05 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:05 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:05 integro volumio[3097]: info: Discovery: A device disappeared from network
Feb 12 18:01:05 integro volumio[3097]: info: Executing endpoint qc_getconfig
Feb 12 18:01:05 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig
Feb 12 18:01:06 integro qobuz-connect[3584]: 20260212 18:01:06.041 [3584.3584] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket
Feb 12 18:01:06 integro volumio[3097]: 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
Feb 12 18:01:06 integro volumio[3097]: info: Spotify config file written
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo
Feb 12 18:01:06 integro volumio[3097]: info: Setting Additional System Software info: Hardware Revision: 1.3
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion
Feb 12 18:01:06 integro volumio[3097]: info: Setting HW Firmware info: undefined
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion
Feb 12 18:01:06 integro volumio[3097]: info: Setting HW Version info: 1.3
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , setAdditionalSVInfo
Feb 12 18:01:06 integro volumio[3097]: info: Setting Additional System Software info: Hardware Revision: 1.3, Firmware Version: 0.7.3
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , setHwFwVersion
Feb 12 18:01:06 integro volumio[3097]: info: Setting HW Firmware info: 0.7.3
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , setHwVersion
Feb 12 18:01:06 integro volumio[3097]: info: Setting HW Version info: 1.3
Feb 12 18:01:06 integro volumio[3097]: info: MCU Signalled PowerOff Capabilities, enabling MCU Poweroff
Feb 12 18:01:06 integro volumio[3097]: info: MCU Signalled Headphone Mode Disabled
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: raat , reportHeadphoneState
Feb 12 18:01:06 integro volumio[3097]: info: MCU Signalled Sleep Mode Disabled
Feb 12 18:01:06 integro sudo[3639]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Feb 12 18:01:06 integro sudo[3639]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:06 integro volumio[3097]: info: Enabling Advanced system settings configuration
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , addAdditionalUISections
Feb 12 18:01:06 integro volumio[3097]: info: Additional UI Settings Added for plugin music_service/inputs
Feb 12 18:01:06 integro volumio[3097]: info: MCU Signalled Auto Boot Mode On Power Disabled
Feb 12 18:01:06 integro qobuz-connect[3584]: 20260212 18:01:06.167 [3584.3584] INFO VolumeManager: [0xac799240]: Setting new playback volume: 75
Feb 12 18:01:06 integro qobuz-connect[3584]: 20260212 18:01:06.167 [3584.3584] INFO VolumeManager: [0xac799240]: Setting new mute state: 0
Feb 12 18:01:06 integro qobuz-connect[3584]: 20260212 18:01:06.167 [3584.3584] INFO QobuzConnect: [0xac799c10]: Client initialized!
Feb 12 18:01:06 integro qobuz-connect[3584]: 20260212 18:01:06.167 [3584.3584] INFO SampleApp: Starting Avahi advertising, name: Integro, service name: _qobuz-connect._tcp
Feb 12 18:01:06 integro sudo[3642]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms force on
Feb 12 18:01:06 integro sudo[3642]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:06 integro volumio[3097]: info: Discovery: A device disappeared from network
Feb 12 18:01:06 integro volumio[3097]: info: Discovery: Device integro disappeared from network
Feb 12 18:01:06 integro systemd[1]: Started go-librespot Daemon.
Feb 12 18:01:06 integro qobuz-connect[3584]: 20260212 18:01:06.196 [3584.3584] INFO LocalConfigManager: [0xac798b20]: Starting Local Configuration server
Feb 12 18:01:06 integro qobuz-connect[3584]: 20260212 18:01:06.196 [3584.3584] INFO SampleApp: Starting Local configuration server
Feb 12 18:01:06 integro qobuz-connect[3584]: 20260212 18:01:06.197 [3584.3584] INFO SampleApp: Connected to UNIX socket client 0xac78eed8
Feb 12 18:01:06 integro qobuz-connect[3584]: 20260212 18:01:06.197 [3584.3584] INFO SampleApp: Playback volume changed: 75
Feb 12 18:01:06 integro sudo[3639]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:06 integro sudo[3642]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:06 integro go-librespot[3644]: go-librespot daemon starting...
Feb 12 18:01:06 integro volumio[3097]: 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
Feb 12 18:01:06 integro volumio[3097]: info: Received Get System Info
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 12 18:01:06 integro volumio[3097]: info: Discovery: Getting this device information
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:06 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 12 18:01:06 integro volumio5-onboarding[3557]: time=2026-02-12T18:01:06.275+09:00 level=INFO msg="system info for b1b7d13aed7c0e5cae19b7aaa1a63844" deviceName=Integro deviceVariant=integro deviceModel="Volumio Integro" softwareVersion=3.908
Feb 12 18:01:06 integro volumio[3097]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6
Feb 12 18:01:06 integro volumio[3097]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object]
Feb 12 18:01:06 integro volumio[3097]: info: QobuzConnect: QOBUZ Connect daemon connected
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: No need to fix Spotify hosts
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro go-librespot[3644]: time="2026-02-12T18:01:06+09:00" level=info msg="running go-librespot 0.6.2"
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro go-librespot[3644]: time="2026-02-12T18:01:06+09:00" level=debug msg="app state loaded"
Feb 12 18:01:06 integro go-librespot[3644]: time="2026-02-12T18:01:06+09:00" level=info msg="api server listening on 127.0.0.1:9879"
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:06 integro volumio[3097]: error: Serial API: Failed to decode command: MAXVOL, message: 40
Feb 12 18:01:06 integro volumio[3097]: error: Serial API: Failed to decode command: MAXVOL, message: 40
Feb 12 18:01:06 integro volumio[3097]: info: Received Get System Info
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 12 18:01:06 integro volumio[3097]: info: Discovery: Getting this device information
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:06 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 12 18:01:06 integro volumio[3097]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:06 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:06 integro volumio[3097]: info: Volumio called home
Feb 12 18:01:06 integro sudo[3666]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/xset dpms 0 0 0
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Feb 12 18:01:06 integro sudo[3666]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:06 integro volumio5-onboarding[3557]: time=2026-02-12T18:01:06.623+09:00 level=INFO msg="enabling local network discovery"
Feb 12 18:01:06 integro sudo[3666]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:06 integro volumio5-onboarding[3557]: time=2026-02-12T18:01:06.638+09:00 level=INFO msg="bootstrapping state" hasInternet=true
Feb 12 18:01:06 integro volumio[3097]: info: Received Get System Info
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Feb 12 18:01:06 integro volumio[3097]: info: Discovery: Getting this device information
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:06 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 12 18:01:06 integro volumio[3097]: info: Adding Inputs via Serial API
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Feb 12 18:01:06 integro volumio[3097]: info: [1770886866813] CoreMusicLibrary::Adding element Inputs
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 12 18:01:06 integro volumio[3097]: info: CoreStateMachine::pushState
Feb 12 18:01:06 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::volumioPushState
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:06 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:06 integro volumio[3097]: info: CoreStateMachine::pushState
Feb 12 18:01:06 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::volumioPushState
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:06 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:06 integro volumio-remote-updater[2825]: No test mode
Feb 12 18:01:06 integro volumio-remote-updater[2825]: No alpha test mode
Feb 12 18:01:06 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:06 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:06 integro volumio[3097]: info: New Spotify access tokenBQBweYBO3Z...
Feb 12 18:01:06 integro volumio[3097]: info: Spotify credentials grant success - running version from March 24, 2019
Feb 12 18:01:06 integro go-librespot[3644]: time="2026-02-12T18:01:06+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-gew1.spotify.com:443 ap-gew4.spotify.com:80]"
Feb 12 18:01:06 integro go-librespot[3644]: time="2026-02-12T18:01:06+09:00" level=debug msg="fetched new dealers: [gae2-dealer.spotify.com:443 guc3-dealer.spotify.com:443 gew1-dealer.spotify.com:443 gew4-dealer.spotify.com:443]"
Feb 12 18:01:06 integro go-librespot[3644]: time="2026-02-12T18:01:06+09:00" level=debug msg="fetched new spclients: [gae2-spclient.spotify.com:443 guc3-spclient.spotify.com:443 gew1-spclient.spotify.com:443 gew4-spclient.spotify.com:443]"
Feb 12 18:01:06 integro go-librespot[3644]: time="2026-02-12T18:01:06+09:00" level=info msg="zeroconf server listening on port 33061"
Feb 12 18:01:07 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:07 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:07 integro volumio[3097]: info: Asound.conf file unchanged, so no further update is needed
Feb 12 18:01:07 integro volumio[3097]: info: Output device has changed, restarting MPD
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=debug msg="obtained new client token: AAA1N3zCkitb9rliN7saFLYyRpSfU2Csj78MO0uqaJ3iK1QQum/6X2C0FTqXFtjbXfHpLLSEQmcxqqCrroHS/ydijDKMEYOSwW7Iwr5HuKcTUd4Gt/LhCbWTRZ/yVaLm3DrQFNr4PsK50JXy6daMyzLuhBcRa7ZBBZHu7orUeqp4sCYaZyXFzchOMk3C565Z4oJzY2a6O1BDWpJzpZuOxVRQIotSgKjHF8CJ60Umo1qIg+nzoVnODvE="
Feb 12 18:01:07 integro sudo[3672]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 12 18:01:07 integro sudo[3672]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:07 integro volumio[3097]: info: QobuzConnect: setDeactiveState invoked
Feb 12 18:01:07 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:07 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:07 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:07 integro sudo[3672]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:07 integro sudo[3675]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 12 18:01:07 integro sudo[3675]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=debug msg="connected to ap-gae2.spotify.com:4070"
Feb 12 18:01:07 integro volumio[3097]: info: Discovery: adding 7c18e49f-20a4-4166-830a-4a248068604b
Feb 12 18:01:07 integro volumio[3097]: info: Discovery: Found device Integro
Feb 12 18:01:07 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:07 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:07 integro volumio[3097]: info: Discovery: adding fc5805da-fd3a-4bf4-9352-ef594b33409a
Feb 12 18:01:07 integro volumio[3097]: info: Discovery: Found device Rivo+
Feb 12 18:01:07 integro systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Feb 12 18:01:07 integro systemd[1]: mpd.service: Succeeded.
Feb 12 18:01:07 integro systemd[1]: Stopped Music Player Daemon.
Feb 12 18:01:07 integro sudo[3681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service
Feb 12 18:01:07 integro sudo[3681]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:07 integro systemd[1]: Starting Music Player Daemon...
Feb 12 18:01:07 integro sudo[3681]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=debug msg="completed keyexchange"
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=debug msg="completed challenge"
Feb 12 18:01:07 integro volumio[3097]: info: CoreCommandRouter::servicePushState
Feb 12 18:01:07 integro volumio[3097]: info: CoreStateMachine::pushState
Feb 12 18:01:07 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:07 integro volumio[3097]: info: CoreCommandRouter::volumioPushState
Feb 12 18:01:07 integro sudo[3684]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service
Feb 12 18:01:07 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:07 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:07 integro volumio[3097]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received inputs
Feb 12 18:01:07 integro volumio[3097]: info: CoreCommandRouter::volumiosetSourceActiveno-source
Feb 12 18:01:07 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Feb 12 18:01:07 integro volumio[3097]: info: CoreStateMachine::pushState
Feb 12 18:01:07 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:07 integro volumio[3097]: info: CoreCommandRouter::volumioPushState
Feb 12 18:01:07 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:07 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:07 integro qobuz-connect[3584]: 20260212 18:01:07.331 [3584.3584] INFO SampleApp: Stopping Local configuration server
Feb 12 18:01:07 integro sudo[3684]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:07 integro systemd[1]: Stopping Volumio Qobuz Connect Service...
Feb 12 18:01:07 integro qobuz-connect[3584]: 20260212 18:01:07.341 [3584.3584] INFO SampleApp: shat down connection on UNIX socket
Feb 12 18:01:07 integro systemd[1]: qobuz-connect.service: Succeeded.
Feb 12 18:01:07 integro systemd[1]: Stopped Volumio Qobuz Connect Service.
Feb 12 18:01:07 integro systemd[1]: Started Volumio Qobuz Connect Service.
Feb 12 18:01:07 integro sudo[3684]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:07 integro volumio[3097]: info: MPD Permissions set
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=info msg="authenticated AP" username="hc*********************ni"
Feb 12 18:01:07 integro volumio[3097]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected
Feb 12 18:01:07 integro volumio[3097]: info: QobuzConnect: setDeactiveState invoked
Feb 12 18:01:07 integro volumio[3097]: info: CoreCommandRouter::volumioGetState
Feb 12 18:01:07 integro volumio[3097]: info: CorePlayQueue::getTrack 0
Feb 12 18:01:07 integro sudo[3683]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 12 18:01:07 integro sudo[3683]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:07 integro sudo[3683]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory
Feb 12 18:01:07 integro sudo[3683]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:07 integro volumio[3097]: info: camilladsp service started and running in background, instance 1
Feb 12 18:01:07 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 12 18:01:07 integro volumio[3097]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Feb 12 18:01:07 integro volumio[3097]: 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 18:01:07 integro volumio[3097]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Feb 12 18:01:07 integro volumio[3097]: info: FusionDsp loaded
Feb 12 18:01:07 integro volumio[3097]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 12 18:01:07 integro sudo[3701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Feb 12 18:01:07 integro sudo[3701]: pam_unix(sudo:session): session opened for user root by (uid=0)
Feb 12 18:01:07 integro volumio[3097]: info: FusionDsp - Reporting Fusion DSP Enabled
Feb 12 18:01:07 integro volumio[3097]: info: Adding Signal Path Element [object Object]
Feb 12 18:01:07 integro volumio[3097]: info: Adding fusiondspeq DSP Signal Path Element
Feb 12 18:01:07 integro volumio[3097]: info: FusionDsp - ---- installed callbackRead
Feb 12 18:01:07 integro volumio[3097]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 12 18:01:07 integro volumio[3097]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Feb 12 18:01:07 integro volumio[3097]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19)
Feb 12 18:01:07 integro volumio[3097]: at onErrorNT (internal/child_process.js:472:16)
Feb 12 18:01:07 integro volumio[3097]: at processTicksAndRejections (internal/process/task_queues.js:82:21)
Feb 12 18:01:07 integro volumio[3097]: at runNextTicks (internal/process/task_queues.js:64:3)
Feb 12 18:01:07 integro volumio[3097]: at listOnTimeout (internal/timers.js:526:9)
Feb 12 18:01:07 integro volumio[3097]: at processTimers (internal/timers.js:500:7) {
Feb 12 18:01:07 integro volumio[3097]: errno: -2,
Feb 12 18:01:07 integro volumio[3097]: code: 'ENOENT',
Feb 12 18:01:07 integro volumio[3097]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Feb 12 18:01:07 integro volumio[3097]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Feb 12 18:01:07 integro volumio[3097]: spawnargs: [
Feb 12 18:01:07 integro volumio[3097]: '-p',
Feb 12 18:01:07 integro volumio[3097]: 9876,
Feb 12 18:01:07 integro volumio[3097]: '-o',
Feb 12 18:01:07 integro volumio[3097]: '/tmp/camilladsp.log',
Feb 12 18:01:07 integro volumio[3097]: '-l',
Feb 12 18:01:07 integro volumio[3097]: 'warn',
Feb 12 18:01:07 integro volumio[3097]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Feb 12 18:01:07 integro volumio[3097]: ]
Feb 12 18:01:07 integro volumio[3097]: }
Feb 12 18:01:07 integro volumio[3097]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 12 18:01:07 integro sudo[3701]: pam_unix(sudo:session): session closed for user root
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=info msg="authenticated Login5" username="hc*********************ni"
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=debug msg="initializing zeroconf session" username="hc*********************ni"
Feb 12 18:01:07 integro systemd[1]: Started FusionDsp Daemon.
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=debug msg="dealer connection opened"
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=trace msg="starting accesspoint recv loop"
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=trace msg="starting dealer recv loop"
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=trace msg="received accesspoint ping"
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=debug msg="skipping packet PacketTypeSecretBlock, len: 336"
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=debug msg="skipping packet PacketTypeLicenseVersion, len: 2"
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=debug msg="skipping packet PacketTypeUnknown1f, len: 17"
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=debug msg="skipping packet PacketTypeLegacyWelcome, len: 0"
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=debug msg="skipping packet PacketTypeMercuryEvent, len: 481"
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=debug msg="received connection id: MjI3NjZmNGQtOGNj...QkM0MTNEREMwMQ=="
Feb 12 18:01:07 integro go-librespot[3644]: time="2026-02-12T18:01:07+09:00" level=trace msg="received accesspoint pong ack"
Feb 12 18:01:08 integro go-librespot[3644]: time="2026-02-12T18:01:08+09:00" level=debug msg="put connect state because NEW_DEVICE"
Feb 12 18:01:08 integro sudo[3713]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-12 18:00
Feb 12 18:01:08 integro sudo[3713]: 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"