[SOLVED] CamillaDSP brief "garbled" output when starting playback

[roderickvd]

I do have a couple other DACs available. I'll give it a go and see if they suffer from the same issue.

I've never had any issues with this particular Topping DAC ever. It only started after I moved to the new release of Moode. (To confirm this, I'm also going to try putting Moode 8 back on the Pi 4.)

Weird! Yeah, let us know.

On a side note... I'm totally going to sponsor your Qobuz Connect project.

Very much appreciated, thank you!

[Tim Curtis]

Do you have another DAC to test with?

Can you describe in more detail what “garbled” means?

I do have a couple other DACs available. I'll give it a go and see if they suffer from the same issue.

By garbled, I mean choppy and broken up sounding. Like if you were having connectivity issues while on a VoIP call. (Make sense?)

I tried swapping in a Raspberry Pi 5 and now the output only works for a brief moment and then goes silent. If I force it to use the output defined in the pipeline editor and set that to "default", it works... but the the audio is in 48kHz. (Instead of the source 44.1kHz.)

I've never had any issues with this particular Topping DAC ever. It only started after I moved to the new release of Moode. (To confirm this, I'm also going to try putting Moode 8 back on the Pi 4.)

On a side note... I'm totally going to sponsor your Qobuz Connect project.

Very odd.

The symptoms suggests some sort of configuration issue.

To troubleshoot I would try the steps below. Just make sure no additional settings changes are made for example restoring from a backup.

1. Pi-5 and Fresh image
2. Plug in Topping DAC
3. Open Audio Config and select it as the Output device
4. Verify that playback works and there are no audio glitches or other issues

5. Open CamillaDSP Config and set Signal processing to V3-Loudness
6. SAVE
7. Verify that playback works and there are no audio glitches or other issues

[kopas]

1. Pi-5 and Fresh image
2. Plug in Topping DAC
3. Open Audio Config and select it as the Output device
4. Verify that playback works and there are no audio glitches or other issues
5. Open CamillaDSP Config and set Signal processing to V3-Loudness
6. SAVE
7. Verify that playback works and there are no audio glitches or other issues

I'll give this all a try next week, thanks for the input!

[kopas]

Here's some additional debug information... Getting a lot of looping warnings in the MPD logs during playback.

Code:

pi@moode:~ $ aplay --dump-hw-params -D hw:0,0 /dev/zero
Playing raw data '/dev/zero' : Unsigned 8 bit, Rate 8000 Hz, Mono
HW Params of device "hw:0,0":
--------------------
ACCESS:  MMAP_INTERLEAVED RW_INTERLEAVED
FORMAT:  S32_LE SPECIAL DSD_U32_BE
SUBFORMAT:  STD
SAMPLE_BITS: 32
FRAME_BITS: 64
CHANNELS: 2
RATE: [44100 384000]
PERIOD_TIME: [125 1000000]
PERIOD_SIZE: [8 384000]
PERIOD_BYTES: [64 3072000]
PERIODS: [2 1024]
BUFFER_TIME: (41 2000000]
BUFFER_SIZE: [16 768000]
BUFFER_BYTES: [128 6144000]
TICK_TIME: ALL
--------------------
aplay: set_params:1352: Sample format non available
Available formats:
- S32_LE
- SPECIAL
- DSD_U32_BE

Code:

pi@moode:~ $ cat /var/log/mpd/log
...
2025-07-21 11:14:17.524468 INFO [src/bin.rs:781] CamillaDSP version 3.0.0
2025-07-21 11:14:17.524485 INFO [src/bin.rs:782] Running on linux, aarch64
2025-07-21 11:14:17.524553 DEBUG [src/bin.rs:820] Loaded state: Some(State { config_path: Some("/usr/share/camilladsp/working_config.yml"), mute: [false, false, false, false, false], volume: [-1.9286548e-15, -6.0, -6.0, -6.0, -6.0] })
2025-07-21 11:14:17.524563 DEBUG [src/bin.rs:823] Using statefile for initial volume
2025-07-21 11:14:17.524566 DEBUG [src/bin.rs:857] Using statefile for initial mute
2025-07-21 11:14:17.524569 DEBUG [src/bin.rs:890] Initial mute: [false, false, false, false, false]
2025-07-21 11:14:17.524571 DEBUG [src/bin.rs:891] Initial volume: [-1.9286548e-15, -6.0, -6.0, -6.0, -6.0]
2025-07-21 11:14:17.524573 DEBUG [src/bin.rs:893] Read config file Some("/usr/share/camilladsp/working_config.yml")
2025-07-21 11:14:17.524576 DEBUG [src/bin.rs:925] No change to state from /var/lib/cdsp/statefile.yml, not overwriting.
2025-07-21 11:14:17.524996 DEBUG [src/config.rs:1514] Apply override for capture_samplerate: 44100
2025-07-21 11:14:17.525007 DEBUG [src/config.rs:1517] Disabling unneccesary 1:1 resampling
2025-07-21 11:14:17.525009 DEBUG [src/config.rs:1536] Apply override for capture channels: 2
2025-07-21 11:14:17.525011 DEBUG [src/config.rs:1584] Apply override for capture sample format: S16LE
2025-07-21 11:14:17.525054 DEBUG [src/biquad.rs:49] a1=-1.9584994900238695 a2=0.9585362453032356 b0=0.9862125850521848 b1=-1.9584994900238695 b2=0.9723236602510507
2025-07-21 11:14:17.525061 DEBUG [src/biquad.rs:49] a1=-1.9917065384054329 a2=0.9918702926948121 b0=1.001052493905881 b1=-1.9917065384054329 b2=0.9908177987889312
2025-07-21 11:14:17.525065 DEBUG [src/biquad.rs:49] a1=-1.9820135886727643 a2=0.9821751999613123 b0=1.0033552229930829 b1=-1.9819421848387757 b2=0.9788913808022178
2025-07-21 11:14:17.525069 DEBUG [src/biquad.rs:49] a1=-1.9829525505528496 a2=0.9838404534945139 b0=1.0080414938319486 b1=-1.9829525505528496 b2=0.9757989596625651
2025-07-21 11:14:17.525071 DEBUG [src/biquad.rs:49] a1=-1.7035025774393606 a2=0.822464981251603 b0=0.9850660889742765 b1=-1.7035025774393606 b2=0.8373988922773264
2025-07-21 11:14:17.525078 DEBUG [src/biquad.rs:49] a1=-1.4085818384716815 a2=0.6436504943508904 b0=1.0735037750440082 b1=-1.4085818384716815 b2=0.5701467193068823
2025-07-21 11:14:17.525081 DEBUG [src/biquad.rs:49] a1=-1.32276004317348 a2=0.7697690180602322 b0=0.9682783102503878 b1=-1.32276004317348 b2=0.8014907078098444
2025-07-21 11:14:17.525085 DEBUG [src/biquad.rs:49] a1=-1.0783730665605968 a2=0.7776165177516022 b0=0.9589655045836547 b1=-1.0783730665605968 b2=0.8186510131679475
2025-07-21 11:14:17.525087 DEBUG [src/biquad.rs:49] a1=-0.6613563735067788 a2=0.7470032334851832 b0=0.9542409158379331 b1=-0.6613563735067788 b2=0.7927623176472499
2025-07-21 11:14:17.525090 DEBUG [src/biquad.rs:49] a1=-0.30447086091517883 a2=0.18992252838303053 b0=0.7788212420067597 b1=-0.028723408526251038 b2=0.13535383398734302
2025-07-21 11:14:17.525092 DEBUG [src/biquad.rs:49] a1=-1.9584994900238695 a2=0.9585362453032356 b0=0.9862125850521848 b1=-1.9584994900238695 b2=0.9723236602510507
2025-07-21 11:14:17.525095 DEBUG [src/biquad.rs:49] a1=-1.9917065384054329 a2=0.9918702926948121 b0=1.001052493905881 b1=-1.9917065384054329 b2=0.9908177987889312
2025-07-21 11:14:17.525097 DEBUG [src/biquad.rs:49] a1=-1.9820135886727643 a2=0.9821751999613123 b0=1.0033552229930829 b1=-1.9819421848387757 b2=0.9788913808022178
2025-07-21 11:14:17.525100 DEBUG [src/biquad.rs:49] a1=-1.9829525505528496 a2=0.9838404534945139 b0=1.0080414938319486 b1=-1.9829525505528496 b2=0.9757989596625651
2025-07-21 11:14:17.525102 DEBUG [src/biquad.rs:49] a1=-1.7035025774393606 a2=0.822464981251603 b0=0.9850660889742765 b1=-1.7035025774393606 b2=0.8373988922773264
2025-07-21 11:14:17.525105 DEBUG [src/biquad.rs:49] a1=-1.4085818384716815 a2=0.6436504943508904 b0=1.0735037750440082 b1=-1.4085818384716815 b2=0.5701467193068823
2025-07-21 11:14:17.525108 DEBUG [src/biquad.rs:49] a1=-1.32276004317348 a2=0.7697690180602322 b0=0.9682783102503878 b1=-1.32276004317348 b2=0.8014907078098444
2025-07-21 11:14:17.525110 DEBUG [src/biquad.rs:49] a1=-1.0783730665605968 a2=0.7776165177516022 b0=0.9589655045836547 b1=-1.0783730665605968 b2=0.8186510131679475
2025-07-21 11:14:17.525113 DEBUG [src/biquad.rs:49] a1=-0.6613563735067788 a2=0.7470032334851832 b0=0.9542409158379331 b1=-0.6613563735067788 b2=0.7927623176472499
2025-07-21 11:14:17.525116 DEBUG [src/biquad.rs:49] a1=-0.30447086091517883 a2=0.18992252838303053 b0=0.7788212420067597 b1=-0.028723408526251038 b2=0.13535383398734302
2025-07-21 11:14:17.525119 DEBUG [src/bin.rs:933] Config is valid
2025-07-21 11:14:17.525191 DEBUG [src/socketserver.rs:450] Start websocket server on 0.0.0.0:1234
2025-07-21 11:14:17.525247 DEBUG [src/bin.rs:1122] Wait for config
2025-07-21 11:14:17.525254 DEBUG [src/bin.rs:1138] Waiting to receive a command
2025-07-21 11:14:17.525257 DEBUG [src/bin.rs:1141] Config change command received
2025-07-21 11:14:17.525259 DEBUG [src/bin.rs:1127] New config is available and there are no queued commands, continuing
2025-07-21 11:14:17.525261 DEBUG [src/bin.rs:1164] Config ready, start processing
2025-07-21 11:14:17.525337 DEBUG [src/bin.rs:163] Using channels [true, true]
2025-07-21 11:14:17.525433 DEBUG [src/filters.rs:347] Build new pipeline
2025-07-21 11:14:17.525479 DEBUG [src/filters.rs:357] Add Mixer step with mixer stereo, pipeline becomes 2 channels wide
2025-07-21 11:14:17.525485 DEBUG [src/filters.rs:370] Add Filter step with filters ["peqgain", "band_01", "band_02", "band_03", "band_04", "band_05", "band_06", "band_07", "band_08", "band_09", "band_10"] to channels [0]
2025-07-21 11:14:17.525499 DEBUG [src/filters.rs:188] Build filter group from config
2025-07-21 11:14:17.525510 DEBUG [src/biquad.rs:49] a1=-1.9584994900238695 a2=0.9585362453032356 b0=0.9862125850521848 b1=-1.9584994900238695 b2=0.9723236602510507
2025-07-21 11:14:17.525515 DEBUG [src/biquad.rs:49] a1=-1.9917065384054329 a2=0.9918702926948121 b0=1.001052493905881 b1=-1.9917065384054329 b2=0.9908177987889312
2025-07-21 11:14:17.525518 DEBUG [src/biquad.rs:49] a1=-1.9820135886727643 a2=0.9821751999613123 b0=1.0033552229930829 b1=-1.9819421848387757 b2=0.9788913808022178
2025-07-21 11:14:17.525521 DEBUG [src/biquad.rs:49] a1=-1.9829525505528496 a2=0.9838404534945139 b0=1.0080414938319486 b1=-1.9829525505528496 b2=0.9757989596625651
2025-07-21 11:14:17.525524 DEBUG [src/biquad.rs:49] a1=-1.7035025774393606 a2=0.822464981251603 b0=0.9850660889742765 b1=-1.7035025774393606 b2=0.8373988922773264
2025-07-21 11:14:17.525524 DEBUG [src/bin.rs:282] Capture thread ready to start
2025-07-21 11:14:17.525530 DEBUG [src/biquad.rs:49] a1=-1.4085818384716815 a2=0.6436504943508904 b0=1.0735037750440082 b1=-1.4085818384716815 b2=0.5701467193068823
2025-07-21 11:14:17.525533 DEBUG [src/biquad.rs:49] a1=-1.32276004317348 a2=0.7697690180602322 b0=0.9682783102503878 b1=-1.32276004317348 b2=0.8014907078098444
2025-07-21 11:14:17.525536 DEBUG [src/biquad.rs:49] a1=-1.0783730665605968 a2=0.7776165177516022 b0=0.9589655045836547 b1=-1.0783730665605968 b2=0.8186510131679475
2025-07-21 11:14:17.525540 DEBUG [src/biquad.rs:49] a1=-0.6613563735067788 a2=0.7470032334851832 b0=0.9542409158379331 b1=-0.6613563735067788 b2=0.7927623176472499
2025-07-21 11:14:17.525543 DEBUG [src/biquad.rs:49] a1=-0.30447086091517883 a2=0.18992252838303053 b0=0.7788212420067597 b1=-0.028723408526251038 b2=0.13535383398734302
2025-07-21 11:14:17.525549 DEBUG [src/filters.rs:370] Add Filter step with filters ["peqgain", "band_01", "band_02", "band_03", "band_04", "band_05", "band_06", "band_07", "band_08", "band_09", "band_10"] to channels [1]
2025-07-21 11:14:17.525556 DEBUG [src/filters.rs:188] Build filter group from config
2025-07-21 11:14:17.525558 DEBUG [src/biquad.rs:49] a1=-1.9584994900238695 a2=0.9585362453032356 b0=0.9862125850521848 b1=-1.9584994900238695 b2=0.9723236602510507
2025-07-21 11:14:17.525561 DEBUG [src/biquad.rs:49] a1=-1.9917065384054329 a2=0.9918702926948121 b0=1.001052493905881 b1=-1.9917065384054329 b2=0.9908177987889312
2025-07-21 11:14:17.525565 DEBUG [src/biquad.rs:49] a1=-1.9820135886727643 a2=0.9821751999613123 b0=1.0033552229930829 b1=-1.9819421848387757 b2=0.9788913808022178
2025-07-21 11:14:17.525567 DEBUG [src/biquad.rs:49] a1=-1.9829525505528496 a2=0.9838404534945139 b0=1.0080414938319486 b1=-1.9829525505528496 b2=0.9757989596625651
2025-07-21 11:14:17.525571 DEBUG [src/biquad.rs:49] a1=-1.7035025774393606 a2=0.822464981251603 b0=0.9850660889742765 b1=-1.7035025774393606 b2=0.8373988922773264
2025-07-21 11:14:17.525577 DEBUG [src/biquad.rs:49] a1=-1.4085818384716815 a2=0.6436504943508904 b0=1.0735037750440082 b1=-1.4085818384716815 b2=0.5701467193068823
2025-07-21 11:14:17.525581 DEBUG [src/biquad.rs:49] a1=-1.32276004317348 a2=0.7697690180602322 b0=0.9682783102503878 b1=-1.32276004317348 b2=0.8014907078098444
2025-07-21 11:14:17.525585 DEBUG [src/biquad.rs:49] a1=-1.0783730665605968 a2=0.7776165177516022 b0=0.9589655045836547 b1=-1.0783730665605968 b2=0.8186510131679475
2025-07-21 11:14:17.525587 DEBUG [src/biquad.rs:49] a1=-0.6613563735067788 a2=0.7470032334851832 b0=0.9542409158379331 b1=-0.6613563735067788 b2=0.7927623176472499
2025-07-21 11:14:17.525591 DEBUG [src/biquad.rs:49] a1=-0.30447086091517883 a2=0.18992252838303053 b0=0.7788212420067597 b1=-0.028723408526251038 b2=0.13535383398734302
2025-07-21 11:14:17.525601 DEBUG [src/processing.rs:47] build filters, waiting to start processing loop
2025-07-21 11:14:17.525608 DEBUG [src/processing.rs:52] Processing thread has real-time priority.
2025-07-21 11:14:17.536671 DEBUG [src/alsadevice.rs:364] Available Playback devices: [("hw:Balanced,0,0", "D10 Balanced, USB Audio, subdevice #0"), ("hw:vc4hdmi0,0,0", "vc4-hdmi-0, MAI PCM i2s-hifi-0, subdevice #0"), ("hw:vc4hdmi1,0,0", "vc4-hdmi-1, MAI PCM i2s-hifi-0, subdevice #0"), ("null", "Discard all samples (playback) or generate zero samples (capture)"), ("default", "Default Audio Device"), ("sysdefault", "Default Audio Device"), ("hw:CARD=Balanced,DEV=0", "D10 Balanced, USB Audio\nDirect hardware device without any conversions"), ("plughw:CARD=Balanced,DEV=0", "D10 Balanced, USB Audio\nHardware device with all software conversions"), ("default:CARD=Balanced", "D10 Balanced, USB Audio\nDefault Audio Device"), ("sysdefault:CARD=Balanced", "D10 Balanced, USB Audio\nDefault Audio Device"), ("front:CARD=Balanced,DEV=0", "D10 Balanced, USB Audio\nFront output / input"), ("surround21:CARD=Balanced,DEV=0", "D10 Balanced, USB Audio\n2.1 Surround output to Front and Subwoofer speakers"), ("surround40:CARD=Balanced,DEV=0", "D10 Balanced, USB Audio\n4.0 Surround output to Front and Rear speakers"), ("surround41:CARD=Balanced,DEV=0", "D10 Balanced, USB Audio\n4.1 Surround output to Front, Rear and Subwoofer speakers"), ("surround50:CARD=Balanced,DEV=0", "D10 Balanced, USB Audio\n5.0 Surround output to Front, Center and Rear speakers"), ("surround51:CARD=Balanced,DEV=0", "D10 Balanced, USB Audio\n5.1 Surround output to Front, Center, Rear and Subwoofer speakers"), ("surround71:CARD=Balanced,DEV=0", "D10 Balanced, USB Audio\n7.1 Surround output to Front, Center, Side, Rear and Woofer speakers"), ("iec958:CARD=Balanced,DEV=0", "D10 Balanced, USB Audio\nIEC958 (S/PDIF) Digital Audio Output"), ("dmix:CARD=Balanced,DEV=0", "D10 Balanced, USB Audio\nDirect sample mixing device"), ("hw:CARD=vc4hdmi0,DEV=0", "vc4-hdmi-0, MAI PCM i2s-hifi-0\nDirect hardware device without any conversions"), ("plughw:CARD=vc4hdmi0,DEV=0", "vc4-hdmi-0, MAI PCM i2s-hifi-0\nHardware device with all software conversions"), ("default:CARD=vc4hdmi0", "vc4-hdmi-0, MAI PCM i2s-hifi-0\nDefault Audio Device"), ("sysdefault:CARD=vc4hdmi0", "vc4-hdmi-0, MAI PCM i2s-hifi-0\nDefault Audio Device"), ("hdmi:CARD=vc4hdmi0,DEV=0", "vc4-hdmi-0, MAI PCM i2s-hifi-0\nHDMI Audio Output"), ("dmix:CARD=vc4hdmi0,DEV=0", "vc4-hdmi-0, MAI PCM i2s-hifi-0\nDirect sample mixing device"), ("hw:CARD=vc4hdmi1,DEV=0", "vc4-hdmi-1, MAI PCM i2s-hifi-0\nDirect hardware device without any conversions"), ("plughw:CARD=vc4hdmi1,DEV=0", "vc4-hdmi-1, MAI PCM i2s-hifi-0\nHardware device with all software conversions"), ("default:CARD=vc4hdmi1", "vc4-hdmi-1, MAI PCM i2s-hifi-0\nDefault Audio Device"), ("sysdefault:CARD=vc4hdmi1", "vc4-hdmi-1, MAI PCM i2s-hifi-0\nDefault Audio Device"), ("hdmi:CARD=vc4hdmi1,DEV=0", "vc4-hdmi-1, MAI PCM i2s-hifi-0\nHDMI Audio Output"), ("dmix:CARD=vc4hdmi1,DEV=0", "vc4-hdmi-1, MAI PCM i2s-hifi-0\nDirect sample mixing device")]
2025-07-21 11:14:17.538420 DEBUG [src/alsadevice.rs:383] Playback: supported channels, min: 1, max: 10000, list: [1, 2, 3, 4, 5, 6, 7, 8, 9, 10, 11, 12, 13, 14, 15, 16, 17, 18, 19, 20, 21, 22, 23, 24, 25, 26, 27, 28, 29, 30, 31, 32]
2025-07-21 11:14:17.538439 DEBUG [src/alsadevice.rs:384] Playback: setting channels to 2
2025-07-21 11:14:17.538620 DEBUG [src/alsadevice.rs:388] Playback: supported samplerates: Range(4000, 4294967295)
2025-07-21 11:14:17.538626 DEBUG [src/alsadevice.rs:389] Playback: setting rate to 44100
2025-07-21 11:14:17.538672 DEBUG [src/alsadevice.rs:393] Playback: supported sample formats: [S16LE, S24LE, S24LE3, S32LE, FLOAT32LE, FLOAT64LE]
2025-07-21 11:14:17.538676 DEBUG [src/alsadevice.rs:403] Playback: setting format to S32LE
2025-07-21 11:14:17.538699 DEBUG [src/alsadevice_buffermanager.rs:57] Setting buffer size to 4096 frames
2025-07-21 11:14:17.538724 DEBUG [src/alsadevice_buffermanager.rs:70] Device is using a buffer size of 4096 frames
2025-07-21 11:14:17.538728 DEBUG [src/alsadevice_buffermanager.rs:78] Setting period size to 512 frames
2025-07-21 11:14:17.538752 DEBUG [src/alsadevice_buffermanager.rs:94] Device is using a period size of 512 frames
2025-07-21 11:14:17.541406 DEBUG [src/alsadevice.rs:427] Opening Playback device "plughw:0,0" with parameters: HwParams { channels: Ok(2), rate: "Ok(44100) Hz", format: Ok(S32LE), access: Ok(RWInterleaved), period_size: "Ok(512) frames", buffer_size: "Ok(4096) frames" }, SwParams(avail_min: Ok(1024) frames, start_threshold: Ok(1) frames, stop_threshold: Ok(4096) frames)
2025-07-21 11:14:17.541429 DEBUG [src/alsadevice.rs:432] Playback device "plughw:0,0" successfully opened
2025-07-21 11:14:17.544871 DEBUG [src/bin.rs:272] Playback thread ready to start
2025-07-21 11:14:17.544900 DEBUG [src/bin.rs:275] Both capture and playback ready, release barrier
2025-07-21 11:14:17.544911 DEBUG [src/bin.rs:277] Supervisor loop starts now!
2025-07-21 11:14:17.544954 DEBUG [src/alsadevice.rs:1141] Starting playback loop
2025-07-21 11:14:17.544971 DEBUG [src/alsadevice.rs:459] Playback device supports pausing the stream
2025-07-21 11:14:17.544974 DEBUG [src/alsadevice.rs:462] Playback loop uses a buffer of 1024 frames
2025-07-21 11:14:17.544999 DEBUG [src/processing.rs:103] Processing loop starts now!
2025-07-21 11:14:17.544928 DEBUG [src/filedevice.rs:666] starting captureloop
2025-07-21 11:14:17.545018 DEBUG [src/filedevice.rs:265] preparing captureloop
2025-07-21 11:14:17.545085 DEBUG [src/alsadevice.rs:495] Playback thread has real-time priority.
2025-07-21 11:14:17.545232 INFO [src/alsadevice.rs:117] PB: Starting playback from Prepared state
2025-07-21 11:14:17.591636 DEBUG [src/filedevice.rs:411] Entering stalled state
2025-07-21 11:14:17.596733 DEBUG [src/filedevice.rs:423] Leaving stalled state, resuming processing
2025-07-21 11:14:17.597053 WARN [src/alsadevice.rs:122] PB: device is in an unexpected state: SND_PCM_STATE_PAUSED, Paused
2025-07-21 11:14:17.643089 INFO [src/alsadevice.rs:556] PB: device stalled
2025-07-21 11:14:17.643106 DEBUG [src/filedevice.rs:411] Entering stalled state
2025-07-21 11:14:17.659418 DEBUG [src/filedevice.rs:423] Leaving stalled state, resuming processing
2025-07-21 11:14:17.659703 WARN [src/alsadevice.rs:122] PB: device is in an unexpected state: SND_PCM_STATE_PAUSED, Paused
2025-07-21 11:14:17.705680 DEBUG [src/filedevice.rs:411] Entering stalled state
2025-07-21 11:14:17.721976 DEBUG [src/filedevice.rs:423] Leaving stalled state, resuming processing
2025-07-21 11:14:17.722196 WARN [src/alsadevice.rs:122] PB: device is in an unexpected state: SND_PCM_STATE_PAUSED, Paused
2025-07-21 11:14:17.768267 WARN [src/alsadevice.rs:122] PB: device is in an unexpected state: SND_PCM_STATE_PAUSED, Paused
2025-07-21 11:14:17.768442 DEBUG [src/filedevice.rs:411] Entering stalled state
2025-07-21 11:14:17.784672 DEBUG [src/filedevice.rs:423] Leaving stalled state, resuming processing
2025-07-21 11:14:17.814321 WARN [src/alsadevice.rs:122] PB: device is in an unexpected state: SND_PCM_STATE_PAUSED, Paused
2025-07-21 11:14:17.831038 DEBUG [src/filedevice.rs:411] Entering stalled state
2025-07-21 11:14:17.847315 DEBUG [src/filedevice.rs:423] Leaving stalled state, resuming processing
2025-07-21 11:14:17.860371 WARN [src/alsadevice.rs:122] PB: device is in an unexpected state: SND_PCM_STATE_PAUSED, Paused
...
2025-07-21 11:14:28.207538 DEBUG [src/filedevice.rs:411] Entering stalled state
2025-07-21 11:14:28.286164 DEBUG [src/filedevice.rs:423] Leaving stalled state, resuming processing
2025-07-21 11:14:28.286437 WARN [src/alsadevice.rs:122] PB: device is in an unexpected state: SND_PCM_STATE_PAUSED, Paused
2025-07-21 11:14:28.332512 DEBUG [src/filedevice.rs:411] Entering stalled state
2025-07-21 11:14:28.411121 DEBUG [src/filedevice.rs:423] Leaving stalled state, resuming processing
2025-07-21 11:14:28.411408 WARN [src/alsadevice.rs:122] PB: device is in an unexpected state: SND_PCM_STATE_PAUSED, Paused
2025-07-21 11:14:28.457487 WARN [src/alsadevice.rs:122] PB: device is in an unexpected state: SND_PCM_STATE_PAUSED, Paused
2025-07-21 11:14:28.457563 DEBUG [src/filedevice.rs:411] Entering stalled state
2025-07-21 11:14:28.536139 DEBUG [src/filedevice.rs:423] Leaving stalled state, resuming processing
2025-07-21 11:14:28.536399 WARN [src/alsadevice.rs:122] PB: device is in an unexpected state: SND_PCM_STATE_PAUSED, Paused
2025-07-21 11:14:28.582508 DEBUG [src/filedevice.rs:411] Entering stalled state
2025-07-21 11:14:28.661114 DEBUG [src/filedevice.rs:423] Leaving stalled state, resuming processing
2025-07-21 11:14:28.661386 WARN [src/alsadevice.rs:122] PB: device is in an unexpected state: SND_PCM_STATE_PAUSED, Paused
2025-07-21 11:14:28.707479 DEBUG [src/filedevice.rs:411] Entering stalled state
2025-07-21 11:14:28.781354 DEBUG [src/filedevice.rs:423] Leaving stalled state, resuming processing
2025-07-21 11:14:28.781555 DEBUG [src/filedevice.rs:352] End of file, read only 1408 of 4096 bytes
2025-07-21 11:14:28.781624 DEBUG [src/filedevice.rs:366] Reached end of file
2025-07-21 11:14:28.781653 INFO [src/bin.rs:390] Capture finished
2025-07-21 11:14:28.781825 DEBUG [src/processing.rs:173] Processing thread returned to normal priority.
2025-07-21 11:14:28.781873 WARN [src/alsadevice.rs:122] PB: device is in an unexpected state: SND_PCM_STATE_PAUSED, Paused
2025-07-21 11:14:28.828001 INFO [src/bin.rs:373] Playback finished
2025-07-21 11:14:28.828001 DEBUG [src/alsadevice.rs:687] Playback thread returned to normal priority.
2025-07-21 11:14:28.828052 DEBUG [src/bin.rs:1166] Processing ended with status Ok(Restart)
2025-07-21 11:14:28.828060 DEBUG [src/bin.rs:1180] Restarting with new config
2025-07-21 11:14:28.828062 DEBUG [src/bin.rs:1122] Wait for config
2025-07-21 11:14:28.828066 DEBUG [src/bin.rs:1132] Wait mode is disabled, there are no queued commands, and no new config. Exiting.
...

[Tim Curtis]

Maybe try posting the mpd log to the main Camilla thread over at diyaudio and see if anyone has some insights.
https://www.diyaudio.com/community/threa...st-8060199

Be sure to mention some details about your configuration and devices, and the CamillaDSP versions which are listed below.

Code:

pi@moode9:~ $ dpkg -l | grep camilla
hi  camilladsp                           3.0.0-1moode1                          arm64        A flexible tool for processing audio
hi  camillagui                           3.0.2-1moode1                          all          CamillaGUI is a web-based GUI for CamillaDSP.
hi  python3-camilladsp                   3.0.0-1moode1                          all          Python library for communicating with CamillaDSP (Python 3)
hi  python3-camilladsp-plot              3.0.0-1moode1                          all          A library for validating, evaluating and plotting configs an

[kopas]

The symptoms suggests some sort of configuration issue.

You were right!

I loaded the stock setup and didn't have any issues with the V3-Loudness config. So, I copied this config and put in all my PEQ filters from Oratory1990... it still worked!

I compared everything and it looks like the chunksize parameter was to blame. Once I changed the setting from 1024 to 4096, my original config worked just fine.

I'm going to try this out on my Raspberry Pi 4 later this week to see if that also fixes the original issue.

[Tim Curtis]

Glad its fixed.