Feb 22 13:53:03 volumio volumio[1157]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/bookworm/armhf
Feb 22 13:53:03 volumio volumio[1157]: info: Folder /tmp/plugins removed
Feb 22 13:53:03 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:03.082+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:03 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:03.695+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:03 volumio volumio[1157]: info: Check plugin dependencies
Feb 22 13:53:03 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Feb 22 13:53:03 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:03.768+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:03 volumio volumio[1157]: info: Checking if plugin already exists
Feb 22 13:53:03 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:03.773+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:03 volumio volumio[1157]: info: Rename folder
Feb 22 13:53:03 volumio volumio[1157]: info: Folder /tmp/downloaded_plugin.zip removed
Feb 22 13:53:03 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:03.821+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:03 volumio volumio[1157]: info: Move to category
Feb 22 13:53:07 volumio go-librespot[5294]: time="2026-02-22T13:53:07+01:00" level=debug msg="prefetching next track" uri="spotify:track:1vBTywtWdIpRRkjRarKB34"
Feb 22 13:53:07 volumio go-librespot[5294]: time="2026-02-22T13:53:07+01:00" level=debug msg="selected format OGG_VORBIS_320 (0ccd6877d42a35fe5f585d765a0450efaa421771)" uri="spotify:track:1vBTywtWdIpRRkjRarKB34"
Feb 22 13:53:07 volumio go-librespot[5294]: time="2026-02-22T13:53:07+01:00" level=debug msg="requested aes key for file 0ccd6877d42a35fe5f585d765a0450efaa421771, gid: 1vBTywtWdIpRRkjRarKB34"
Feb 22 13:53:07 volumio go-librespot[5294]: time="2026-02-22T13:53:07+01:00" level=trace msg="found 2 cdn urls" uri="spotify:track:1vBTywtWdIpRRkjRarKB34"
Feb 22 13:53:08 volumio go-librespot[5294]: time="2026-02-22T13:53:08+01:00" level=debug msg="fetched first chunk of 15, total size is 7584130 bytes" uri="spotify:track:1vBTywtWdIpRRkjRarKB34"
Feb 22 13:53:08 volumio go-librespot[5294]: time="2026-02-22T13:53:08+01:00" level=info msg="prefetched track \"cøøl\" (duration: 162061ms)" uri="spotify:track:1vBTywtWdIpRRkjRarKB34"
Feb 22 13:53:08 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:08.434+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:08 volumio volumio[1157]: info: Checking if install.sh is present
Feb 22 13:53:08 volumio volumio[1157]: info: Executing install.sh
Feb 22 13:53:08 volumio go-librespot[5294]: time="2026-02-22T13:53:08+01:00" level=debug msg="fetched chunk 1/14, size: 524288" uri="spotify:track:1vBTywtWdIpRRkjRarKB34"
Feb 22 13:53:08 volumio sudo[9446]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh
Feb 22 13:53:08 volumio sudo[9446]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 13:53:08 volumio volumio[1157]: info: creating filters folder and copying demo filters
Feb 22 13:53:08 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:08.694+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:08 volumio volumio[1157]: info: copying demo flters
Feb 22 13:53:08 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:08.812+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:08 volumio go-librespot[5294]: time="2026-02-22T13:53:08+01:00" level=debug msg="fetched chunk 3/14, size: 524288" uri="spotify:track:1vBTywtWdIpRRkjRarKB34"
Feb 22 13:53:08 volumio go-librespot[5294]: time="2026-02-22T13:53:08+01:00" level=debug msg="fetched chunk 2/14, size: 524288" uri="spotify:track:1vBTywtWdIpRRkjRarKB34"
Feb 22 13:53:08 volumio volumio[1157]: info: ./presets/
Feb 22 13:53:08 volumio go-librespot[5294]: time="2026-02-22T13:53:08+01:00" level=trace msg="sent dealer ping"
Feb 22 13:53:08 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:08.964+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:08 volumio volumio[1157]: info: ./presets/2XEQ15/
Feb 22 13:53:08 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:08.970+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:08 volumio volumio[1157]: info: ./presets/2XEQ15/.Bass-FusionDsp.json
Feb 22 13:53:08 volumio volumio[1157]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json
Feb 22 13:53:08 volumio volumio[1157]: info: ./presets/2XEQ15/.Classic-FusionDsp.json
Feb 22 13:53:08 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:08.985+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:08 volumio volumio[1157]: info: ./presets/2XEQ15/.Voice-FusionDsp.json
Feb 22 13:53:08 volumio volumio[1157]: info: ./presets/2XEQ15/.Rock-FusionDsp.json
Feb 22 13:53:08 volumio volumio[1157]: info: ./presets/PEQ/
Feb 22 13:53:08 volumio volumio[1157]: info: ./presets/convfir/
Feb 22 13:53:08 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:08.997+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:08.999+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:08.999+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:09.000+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:09.000+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:09.000+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio[1157]: info: ./presets/convfir/kef.json
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:09.029+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio[1157]: info: ./presets/convfir/test.json
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:09.039+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio[1157]: info: ./presets/EQ15/
Feb 22 13:53:09 volumio volumio[1157]: info: ./presets/EQ15/.Bass-FusionDsp.json
Feb 22 13:53:09 volumio volumio[1157]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json
Feb 22 13:53:09 volumio volumio[1157]: info: ./presets/EQ15/.Classic-FusionDsp.json
Feb 22 13:53:09 volumio volumio[1157]: info: ./presets/EQ15/.Voice-FusionDsp.json
Feb 22 13:53:09 volumio volumio[1157]: info: ./presets/EQ15/.Rock-FusionDsp.json
Feb 22 13:53:09 volumio go-librespot[5294]: time="2026-02-22T13:53:09+01:00" level=trace msg="received dealer pong"
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:09.055+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:09.056+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:09.058+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:09.059+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:09.060+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:09.060+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio[1157]: info: Installing/fusiondsp dependencies
Feb 22 13:53:09 volumio sudo[9474]: root : PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update
Feb 22 13:53:09 volumio sudo[9474]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:09.092+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio[1157]: info: Get:1 http://raspbian.raspberrypi.com/raspbian bookworm InRelease [15.0 kB]
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:09.855+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:09 volumio volumio[1157]: info: Get:2 http://archive.raspberrypi.com/debian bookworm InRelease [55.0 kB]
Feb 22 13:53:09 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:09.866+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:10 volumio volumio[1157]: info: Get:3 http://raspbian.raspberrypi.com/raspbian bookworm/main armhf Packages [14.5 MB]
Feb 22 13:53:10 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:10.743+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:11 volumio volumio[1157]: info: Get:4 http://archive.raspberrypi.com/debian bookworm/main armhf Packages [563 kB]
Feb 22 13:53:11 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:11.439+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:11 volumio volumio[1157]: info: Get:5 http://archive.raspberrypi.com/debian bookworm/untested armhf Packages [1114 B]
Feb 22 13:53:11 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:11.952+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:15 volumio volumio[1157]: info: Get:6 http://raspbian.raspberrypi.com/raspbian bookworm/contrib armhf Packages [62.3 kB]
Feb 22 13:53:15 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:15.206+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:15 volumio volumio[1157]: info: Get:7 http://raspbian.raspberrypi.com/raspbian bookworm/non-free armhf Packages [118 kB]
Feb 22 13:53:15 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:15.394+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:15 volumio volumio[1157]: info: Get:8 http://raspbian.raspberrypi.com/raspbian bookworm/rpi armhf Packages [1360 B]
Feb 22 13:53:15 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:15.569+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:29 volumio volumio[1157]: info: Fetched 15.3 MB in 20s (748 kB/s)
Feb 22 13:53:29 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:29.761+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:36 volumio go-librespot[5294]: time="2026-02-22T13:53:36+01:00" level=trace msg="emitting websocket event: not_playing"
Feb 22 13:53:36 volumio go-librespot[5294]: time="2026-02-22T13:53:36+01:00" level=debug msg="loading track (paused: false, position: 0ms)" uri="spotify:track:1vBTywtWdIpRRkjRarKB34"
Feb 22 13:53:36 volumio volumio[1157]: SPOTIFY: received: {"type":"not_playing","data":{"context_uri":"spotify:artist:5m2pDQbSRuWbxRR1FUcHle","uri":"spotify:track:28yArnPkJk7XDWnr7cnl6g","play_origin":"free-tier-artist"}}
Feb 22 13:53:36 volumio volumio[1157]: error: Failed to decode event: not_playing
Feb 22 13:53:36 volumio volumio[1157]: SPOTIFY: received: {"type":"not_playing","data":{"context_uri":"spotify:artist:5m2pDQbSRuWbxRR1FUcHle","uri":"spotify:track:28yArnPkJk7XDWnr7cnl6g","play_origin":"free-tier-artist"}}
Feb 22 13:53:36 volumio volumio[1157]: error: Failed to decode event: not_playing
Feb 22 13:53:36 volumio go-librespot[5294]: time="2026-02-22T13:53:36+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Feb 22 13:53:36 volumio go-librespot[5294]: time="2026-02-22T13:53:36+01:00" level=trace msg="emitting websocket event: will_play"
Feb 22 13:53:36 volumio go-librespot[5294]: time="2026-02-22T13:53:36+01:00" level=info msg="loaded track \"cøøl\" (paused: false, position: 0ms, duration: 162061ms, prefetched: true)" uri="spotify:track:1vBTywtWdIpRRkjRarKB34"
Feb 22 13:53:36 volumio volumio[1157]: SPOTIFY: received: {"type":"will_play","data":{"context_uri":"spotify:artist:5m2pDQbSRuWbxRR1FUcHle","uri":"spotify:track:1vBTywtWdIpRRkjRarKB34","play_origin":"free-tier-artist"}}
Feb 22 13:53:36 volumio volumio[1157]: SPOTIFY: received: {"type":"will_play","data":{"context_uri":"spotify:artist:5m2pDQbSRuWbxRR1FUcHle","uri":"spotify:track:1vBTywtWdIpRRkjRarKB34","play_origin":"free-tier-artist"}}
Feb 22 13:53:36 volumio go-librespot[5294]: time="2026-02-22T13:53:36+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Feb 22 13:53:36 volumio go-librespot[5294]: time="2026-02-22T13:53:36+01:00" level=trace msg="scheduling prefetch in 132s"
Feb 22 13:53:36 volumio go-librespot[5294]: time="2026-02-22T13:53:36+01:00" level=trace msg="emitting websocket event: metadata"
Feb 22 13:53:36 volumio volumio[1157]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:1vBTywtWdIpRRkjRarKB34","name":"cøøl","artist_names":["Mirai"],"album_name":"TOMODACHI (Deluxe)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02f448bb803913c8411b6b0d3e","position":0,"duration":162061,"release_date":"year:2024 month:11 day:8","track_number":1,"disc_number":1}}
Feb 22 13:53:36 volumio volumio[1157]: SPOTIFY: received: {"type":"metadata","data":{"uri":"spotify:track:1vBTywtWdIpRRkjRarKB34","name":"cøøl","artist_names":["Mirai"],"album_name":"TOMODACHI (Deluxe)","album_cover_url":"https://i.scdn.co/image/ab67616d00001e02f448bb803913c8411b6b0d3e","position":0,"duration":162061,"release_date":"year:2024 month:11 day:8","track_number":1,"disc_number":1}}
Feb 22 13:53:37 volumio go-librespot[5294]: time="2026-02-22T13:53:37+01:00" level=debug msg="put connect state because PLAYER_STATE_CHANGED"
Feb 22 13:53:37 volumio go-librespot[5294]: time="2026-02-22T13:53:37+01:00" level=trace msg="emitting websocket event: playing"
Feb 22 13:53:37 volumio volumio[1157]: SPOTIFY: received: {"type":"playing","data":{"context_uri":"spotify:artist:5m2pDQbSRuWbxRR1FUcHle","uri":"spotify:track:1vBTywtWdIpRRkjRarKB34","resume":false,"play_origin":"free-tier-artist"}}
Feb 22 13:53:37 volumio volumio[1157]: SPOTIFY: PUSH STATE SPOTIFY
Feb 22 13:53:37 volumio volumio[1157]: SPOTIFY: {"status":"play","service":"spop","title":"cøøl","artist":"Mirai","album":"TOMODACHI (Deluxe)","albumart":"https://i.scdn.co/image/ab67616d00001e02f448bb803913c8411b6b0d3e","uri":"spotify:track:1vBTywtWdIpRRkjRarKB34","trackType":"spotify","seek":0,"duration":162,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Feb 22 13:53:37 volumio volumio[1157]: info: CoreCommandRouter::servicePushState
Feb 22 13:53:37 volumio volumio[1157]: info: CoreStateMachine::pushState
Feb 22 13:53:37 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Feb 22 13:53:37 volumio volumio[1157]: info: CoreCommandRouter::volumioPushState
Feb 22 13:53:37 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:37.046+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.120:49774 @ 0x24002d0" state=STATUS_PLAYING positionMs=0 volume=68
Feb 22 13:53:37 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:37.047+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.120:49774 @ 0x24002d0" id=spotify:track:1vBTywtWdIpRRkjRarKB34 title=cøøl
Feb 22 13:53:37 volumio volumio[1157]: SPOTIFY: received: {"type":"playing","data":{"context_uri":"spotify:artist:5m2pDQbSRuWbxRR1FUcHle","uri":"spotify:track:1vBTywtWdIpRRkjRarKB34","resume":false,"play_origin":"free-tier-artist"}}
Feb 22 13:53:37 volumio volumio[1157]: SPOTIFY: PUSH STATE SPOTIFY
Feb 22 13:53:37 volumio volumio[1157]: SPOTIFY: {"status":"play","service":"spop","title":"cøøl","artist":"Mirai","album":"TOMODACHI (Deluxe)","albumart":"https://i.scdn.co/image/ab67616d00001e02f448bb803913c8411b6b0d3e","uri":"spotify:track:1vBTywtWdIpRRkjRarKB34","trackType":"spotify","seek":0,"duration":162,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Feb 22 13:53:37 volumio volumio[1157]: info: CoreCommandRouter::servicePushState
Feb 22 13:53:37 volumio volumio[1157]: info: CoreStateMachine::pushState
Feb 22 13:53:37 volumio volumio[1157]: info: CoreCommandRouter::volumioPushState
Feb 22 13:53:37 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:37.064+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.120:49774 @ 0x24002d0" state=STATUS_PLAYING positionMs=0 volume=68
Feb 22 13:53:37 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:37.065+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.120:49774 @ 0x24002d0" id=spotify:track:1vBTywtWdIpRRkjRarKB34 title=cøøl
Feb 22 13:53:37 volumio volumio[1157]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68
Feb 22 13:53:37 volumio volumio[1157]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68
Feb 22 13:53:37 volumio volumio[1157]: SPOTIFY: PUSH STATE SPOTIFY
Feb 22 13:53:37 volumio volumio[1157]: SPOTIFY: {"status":"play","service":"spop","title":"cøøl","artist":"Mirai","album":"TOMODACHI (Deluxe)","albumart":"https://i.scdn.co/image/ab67616d00001e02f448bb803913c8411b6b0d3e","uri":"spotify:track:1vBTywtWdIpRRkjRarKB34","trackType":"spotify","seek":0,"duration":162,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Feb 22 13:53:37 volumio volumio[1157]: info: CoreCommandRouter::servicePushState
Feb 22 13:53:37 volumio volumio[1157]: info: CoreStateMachine::pushState
Feb 22 13:53:37 volumio volumio[1157]: info: CoreCommandRouter::volumioPushState
Feb 22 13:53:37 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:37.346+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.120:49774 @ 0x24002d0" state=STATUS_PLAYING positionMs=0 volume=68
Feb 22 13:53:37 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:37.347+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.120:49774 @ 0x24002d0" id=spotify:track:1vBTywtWdIpRRkjRarKB34 title=cøøl
Feb 22 13:53:37 volumio volumio[1157]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68
Feb 22 13:53:37 volumio volumio[1157]: SPOTIFY: PUSH STATE SPOTIFY
Feb 22 13:53:37 volumio volumio[1157]: SPOTIFY: {"status":"play","service":"spop","title":"cøøl","artist":"Mirai","album":"TOMODACHI (Deluxe)","albumart":"https://i.scdn.co/image/ab67616d00001e02f448bb803913c8411b6b0d3e","uri":"spotify:track:1vBTywtWdIpRRkjRarKB34","trackType":"spotify","seek":0,"duration":162,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"320 kbps","codec":"ogg","channels":2,"random":null,"repeat":null,"repeatSingle":null,"stream":false,"repeatMode":"all"}
Feb 22 13:53:37 volumio volumio[1157]: info: CoreCommandRouter::servicePushState
Feb 22 13:53:37 volumio volumio[1157]: info: CoreStateMachine::pushState
Feb 22 13:53:37 volumio volumio[1157]: info: CoreCommandRouter::volumioPushState
Feb 22 13:53:37 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:37.369+01:00 level=INFO msg="emitting player state changed event" component=server peer="192.168.1.120:49774 @ 0x24002d0" state=STATUS_PLAYING positionMs=0 volume=68
Feb 22 13:53:37 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:37.370+01:00 level=INFO msg="emitting player metadata changed event" component=server peer="192.168.1.120:49774 @ 0x24002d0" id=spotify:track:1vBTywtWdIpRRkjRarKB34 title=cøøl
Feb 22 13:53:37 volumio volumio[1157]: SPOTIFY: RECEIVED VOLUMIO VOLUME 68
Feb 22 13:53:38 volumio go-librespot[5294]: time="2026-02-22T13:53:38+01:00" level=trace msg="sent dealer ping"
Feb 22 13:53:39 volumio go-librespot[5294]: time="2026-02-22T13:53:39+01:00" level=trace msg="received dealer pong"
Feb 22 13:53:46 volumio volumio[1157]: info: Reading package lists...
Feb 22 13:53:46 volumio sudo[9474]: pam_unix(sudo:session): session closed for user root
Feb 22 13:53:46 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:46.924+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:46 volumio sudo[9679]: root : PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install --no-install-recommends python3-venv drc
Feb 22 13:53:46 volumio sudo[9679]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 22 13:53:47 volumio volumio[1157]: info: Reading package lists...
Feb 22 13:53:47 volumio sudo[9679]: pam_unix(sudo:session): session closed for user root
Feb 22 13:53:47 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:47.869+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:47 volumio volumio[1157]: info: creating sysytemd service
Feb 22 13:53:47 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:47.915+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:47 volumio sudo[9688]: root : PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/systemctl daemon-reload
Feb 22 13:53:47 volumio sudo[9688]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 22 13:53:48 volumio systemd[1]: Reloading.
Feb 22 13:53:49 volumio go-librespot[5294]: time="2026-02-22T13:53:49+01:00" level=debug msg="fetched chunk 4/14, size: 524288" uri="spotify:track:1vBTywtWdIpRRkjRarKB34"
Feb 22 13:53:50 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:9: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
Feb 22 13:53:50 volumio systemd[1]: /lib/systemd/system/go-librespot-daemon.service:10: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
Feb 22 13:53:50 volumio sudo[9688]: pam_unix(sudo:session): session closed for user root
Feb 22 13:53:50 volumio volumio[1157]: info: copying hw detection script
Feb 22 13:53:50 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:50.473+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:50 volumio volumio[1157]: info: Detected cpu architecture as armv7l
Feb 22 13:53:50 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:50.527+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:52 volumio sudo[9733]: root : PWD=/tmp ; USER=root ; COMMAND=/usr/bin/cp /data/plugins/audio_interface/fusiondsp/c/hw_params_arm /data/plugins/audio_interface/fusiondsp/hw_params
Feb 22 13:53:52 volumio sudo[9733]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 22 13:53:52 volumio sudo[9733]: pam_unix(sudo:session): session closed for user root
Feb 22 13:53:52 volumio sudo[9735]: root : PWD=/tmp ; USER=root ; COMMAND=/usr/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params
Feb 22 13:53:52 volumio sudo[9735]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 22 13:53:52 volumio sudo[9735]: pam_unix(sudo:session): session closed for user root
Feb 22 13:53:52 volumio volumio[1157]: info: Downloading camillagui ... Please wait!
Feb 22 13:53:52 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:52.741+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:54 volumio volumio[1157]: info: Extracting camillagui ...
Feb 22 13:53:54 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:54.446+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:54 volumio sudo[9446]: pam_unix(sudo:session): session closed for user root
Feb 22 13:53:54 volumio volumio[1157]: Plugin install end detected on script
Feb 22 13:53:54 volumio volumio[1157]: info: Install script completed
Feb 22 13:53:54 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:54.501+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:54 volumio volumio[1157]: info: Adding reference to registry
Feb 22 13:53:54 volumio volumio5-onboarding[1617]: time=2026-02-22T13:53:54.511+01:00 level=WARN msg="received plugin install progress but no plugin is being installed" component=state
Feb 22 13:53:54 volumio volumio[1157]: info: Done installing plugin.
Feb 22 13:53:54 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
Feb 22 13:53:54 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
Feb 22 13:53:54 volumio volumio[1157]: info: Folder /tmp/plugins removed
Feb 22 13:53:54 volumio volumio[1157]: info: Folder /tmp/downloaded_plugin.zip removed
Feb 22 13:53:54 volumio volumio[1157]: info: Folder /data/temp removed
Feb 22 13:53:59 volumio volumio[1157]: info: Enabling plugin fusiondsp
Feb 22 13:53:59 volumio volumio[1157]: info: Loading plugin "fusiondsp"...
Feb 22 13:53:59 volumio volumio[1157]: error: Could not copy default configuration to /data/configuration/audio_interface/fusiondsp/config.json
Feb 22 13:54:00 volumio volumio[1157]: info: Preparing to generate the ALSA configuration file
Feb 22 13:54:00 volumio volumio[1157]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Feb 22 13:54:00 volumio volumio[1157]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Feb 22 13:54:00 volumio volumio[1157]: info: Reading ALSA contributions from plugins.
Feb 22 13:54:00 volumio volumio[1157]: error: Cannot write /etc/asound.conf: Error: ENOSPC: no space left on device, write
Feb 22 13:54:00 volumio volumio[1157]: info: Output device has changed, restarting MPD
Feb 22 13:54:00 volumio volumio[1157]: info: Output device has changed, restarting Shairport Sync
Feb 22 13:54:00 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:00 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 13:54:00 volumio sudo[9749]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 22 13:54:00 volumio sudo[9749]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 13:54:00 volumio sudo[9749]: pam_unix(sudo:session): session closed for user root
Feb 22 13:54:00 volumio sudo[9751]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 22 13:54:00 volumio sudo[9751]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 13:54:00 volumio volumio[1157]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 22 13:54:00 volumio volumio[1157]: info: PLUGIN START: fusiondsp
Feb 22 13:54:00 volumio systemd[1]: Stopping mpd.service - Music Player Daemon...
Feb 22 13:54:00 volumio volumio[1157]: info: FusionDsp - CamillaDSP binary found.
Feb 22 13:54:00 volumio volumio[1157]: info: Loading i18n strings for locale cs
Feb 22 13:54:00 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Feb 22 13:54:00 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:00 volumio volumio[1157]: info: FusionDsp - mixtype--------------------- Software
Feb 22 13:54:00 volumio volumio[1157]: info: Preparing to generate the ALSA configuration file
Feb 22 13:54:00 volumio volumio[1157]: info: Done.
Feb 22 13:54:00 volumio volumio[1157]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Feb 22 13:54:00 volumio volumio[1157]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Feb 22 13:54:00 volumio volumio[1157]: info: Reading ALSA contributions from plugins.
Feb 22 13:54:00 volumio volumio[1157]: info: MPD Permissions set
Feb 22 13:54:00 volumio volumio[1157]: info: CoreCommandRouter::getUIConfigOnPlugin
Feb 22 13:54:00 volumio volumio[1157]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8
Feb 22 13:54:00 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:00 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:00 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:00 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:00 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:00 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:00 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:00 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:00 volumio go-librespot[5294]: time="2026-02-22T13:54:00+01:00" level=debug msg="fetched chunk 5/14, size: 524288" uri="spotify:track:1vBTywtWdIpRRkjRarKB34"
Feb 22 13:54:00 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 13:54:00 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:00 volumio volumio[1157]: error: FusionDsp - failed to read local file for preset: Error: ENOENT: no such file or directory, scandir '/data/INTERNAL/FusionDsp/presets//undefined'
Feb 22 13:54:00 volumio systemd[1]: mpd.service: Deactivated successfully.
Feb 22 13:54:00 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Feb 22 13:54:00 volumio systemd[1]: mpd.service: Consumed 1min 15.018s CPU time.
Feb 22 13:54:00 volumio systemd[1]: mpd.socket: Deactivated successfully.
Feb 22 13:54:00 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Feb 22 13:54:00 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Feb 22 13:54:00 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Feb 22 13:54:01 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Feb 22 13:54:01 volumio volumio[1157]: error: FusionDsp - Error: TypeError: Cannot read properties of undefined (reading 'split')
Feb 22 13:54:01 volumio volumio[1157]: info: Starting Shairport Sync
Feb 22 13:54:01 volumio sudo[9769]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 22 13:54:01 volumio sudo[9769]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 13:54:01 volumio volumio[1157]: error: Cannot write /etc/asound.conf: Error: ENOSPC: no space left on device, write
Feb 22 13:54:01 volumio volumio[1157]: info: Output device has changed, restarting MPD
Feb 22 13:54:01 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Feb 22 13:54:01 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Feb 22 13:54:01 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 22 13:54:01 volumio systemd[1]: shairport-sync.service: Consumed 23.341s CPU time.
Feb 22 13:54:01 volumio volumio[1157]: info: Output device has changed, restarting Shairport Sync
Feb 22 13:54:01 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:01 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 13:54:01 volumio sudo[9775]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Feb 22 13:54:01 volumio sudo[9775]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 13:54:01 volumio sudo[9772]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Feb 22 13:54:01 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 22 13:54:01 volumio sudo[9772]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 13:54:01 volumio sudo[9769]: pam_unix(sudo:session): session closed for user root
Feb 22 13:54:01 volumio volumio[1157]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Feb 22 13:54:01 volumio sudo[9772]: pam_unix(sudo:session): session closed for user root
Feb 22 13:54:01 volumio volumio[1157]: info: Shairport-Sync Started
Feb 22 13:54:01 volumio systemd[1]: mpd.service: Deactivated successfully.
Feb 22 13:54:01 volumio systemd[1]: Stopped mpd.service - Music Player Daemon.
Feb 22 13:54:01 volumio systemd[1]: mpd.socket: Deactivated successfully.
Feb 22 13:54:01 volumio systemd[1]: Closed mpd.socket - Music Player Daemon Socket.
Feb 22 13:54:01 volumio systemd[1]: Stopping mpd.socket - Music Player Daemon Socket...
Feb 22 13:54:01 volumio volumio[1157]: info: MPD Permissions set
Feb 22 13:54:01 volumio volumio[1157]: Configuration write error: Error: ENOENT: no such file or directory, open '/data/configuration/audio_interface/fusiondsp/config.json'
Feb 22 13:54:01 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:01 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:01 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:01 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:01 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:01 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:01 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:01 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:01 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Feb 22 13:54:01 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:01 volumio volumio[1157]: info: Starting Shairport Sync
Feb 22 13:54:01 volumio systemd[1]: Listening on mpd.socket - Music Player Daemon Socket.
Feb 22 13:54:01 volumio systemd[1]: Starting mpd.service - Music Player Daemon...
Feb 22 13:54:01 volumio sudo[9805]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Feb 22 13:54:01 volumio sudo[9805]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 13:54:01 volumio systemd[1]: Stopping shairport-sync.service - Shairport Sync - AirPlay Audio Receiver...
Feb 22 13:54:01 volumio systemd[1]: shairport-sync.service: Deactivated successfully.
Feb 22 13:54:01 volumio systemd[1]: Stopped shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 22 13:54:01 volumio systemd[1]: Started shairport-sync.service - Shairport Sync - AirPlay Audio Receiver.
Feb 22 13:54:01 volumio sudo[9805]: pam_unix(sudo:session): session closed for user root
Feb 22 13:54:01 volumio volumio[1157]: info: Shairport-Sync Started
Feb 22 13:54:01 volumio volumio[1157]: (node:1157) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pbeg listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Feb 22 13:54:01 volumio volumio[1157]: (Use `node --trace-warnings ...` to show where the warning was created)
Feb 22 13:54:01 volumio volumio[1157]: (node:1157) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 meta listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Feb 22 13:54:01 volumio volumio[1157]: (node:1157) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 prgr listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Feb 22 13:54:01 volumio volumio[1157]: (node:1157) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pvol listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Feb 22 13:54:01 volumio volumio[1157]: (node:1157) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 pend listeners added to [ShairportSyncReaderUDP]. Use emitter.setMaxListeners() to increase limit
Feb 22 13:54:02 volumio sudo[9804]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Feb 22 13:54:02 volumio sudo[9804]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Feb 22 13:54:02 volumio sudo[9804]: pam_unix(sudo:session): session closed for user root
Feb 22 13:54:02 volumio volumio[1157]: info: FusionDsp - If filter freq >samplerate/2 then disable it
Feb 22 13:54:02 volumio volumio[1157]: error: Cannot read properties of undefined (reading 'toString')
Feb 22 13:54:02 volumio volumio[1157]: info: camilladsp service started and running in background, instance 1
Feb 22 13:54:02 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Feb 22 13:54:02 volumio volumio[1157]: /bin/sh: 1: cannot create /data/configuration/audio_interface/fusiondsp/hwinfo.json: Directory nonexistent
Feb 22 13:54:02 volumio volumio[1157]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Feb 22 13:54:02 volumio volumio[1157]: /bin/sh: 1: cannot create /data/configuration/audio_interface/fusiondsp/hwinfo.json: Directory nonexistent
Feb 22 13:54:02 volumio volumio[1157]: info: FusionDsp loaded
Feb 22 13:54:02 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Feb 22 13:54:02 volumio volumio[1157]: info: FusionDsp - --[object Object]
Feb 22 13:54:02 volumio volumio[1157]: info: FusionDsp - Reporting Fusion DSP Enabled
Feb 22 13:54:02 volumio volumio[1157]: info: Adding Signal Path Element [object Object]
Feb 22 13:54:02 volumio volumio[1157]: info: Adding fusiondspeq DSP Signal Path Element
Feb 22 13:54:02 volumio volumio[1157]: info: FusionDsp - ---- installed callbackRead (debounced 200ms)
Feb 22 13:54:02 volumio volumio[1157]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 22 13:54:02 volumio volumio[1157]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp EACCES
Feb 22 13:54:02 volumio volumio[1157]: at ChildProcess._handle.onexit (node:internal/child_process:286:19)
Feb 22 13:54:02 volumio volumio[1157]: at onErrorNT (node:internal/child_process:484:16)
Feb 22 13:54:02 volumio volumio[1157]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) {
Feb 22 13:54:02 volumio volumio[1157]: errno: -13,
Feb 22 13:54:02 volumio volumio[1157]: code: 'EACCES',
Feb 22 13:54:02 volumio volumio[1157]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Feb 22 13:54:02 volumio volumio[1157]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Feb 22 13:54:02 volumio volumio[1157]: spawnargs: [
Feb 22 13:54:02 volumio volumio[1157]: '-p',
Feb 22 13:54:02 volumio volumio[1157]: 9876,
Feb 22 13:54:02 volumio volumio[1157]: '-o',
Feb 22 13:54:02 volumio volumio[1157]: '/tmp/camilladsp.log',
Feb 22 13:54:02 volumio volumio[1157]: '-l',
Feb 22 13:54:02 volumio volumio[1157]: 'warn',
Feb 22 13:54:02 volumio volumio[1157]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Feb 22 13:54:02 volumio volumio[1157]: ]
Feb 22 13:54:02 volumio volumio[1157]: }
Feb 22 13:54:02 volumio volumio[1157]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Feb 22 13:54:02 volumio sudo[9835]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Feb 22 13:54:02 volumio sudo[9835]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
Feb 22 13:54:02 volumio sudo[9835]: pam_unix(sudo:session): session closed for user root
Feb 22 13:54:04 volumio sudo[9852]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-22 13:53'
Feb 22 13:54:04 volumio sudo[9852]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)"
NAME="Raspbian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=raspbian
ID_LIKE=debian
HOME_URL="http://www.raspbian.org/"
SUPPORT_URL="http://www.raspbian.org/RaspbianForums"
BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs"
VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Feb 5 14:07:07 UTC 2026"
VOLUMIO_VERSION="4.096"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="5e37060f9823263a753eb5e84030104f"