snapcast
snapcast copied to clipboard
Published
20 hours ago •
badaix
badaix
Snapclient stutters with bluetooth headphones (Exception: Not enough frames available)
Describe the bug
The moment I switch the audio output on my PC to Bluetooth headsets snapclient starts to stutter or stops playing. If I reduce the --player option, it wont work at all. The moment I switch back to my loudspeakers, it is working as bevore.
Steps to Reproduce
- Start snapclient with any options
- Connect headphones and set as audio output
Environment details
- OS: Arch Linux 6.2.2-arch1-1
- Snapcast version 0.27.0
- Installed from the AUR package, but this compieles it
Attach logfile if applicable
Generate logs with snapclient --logfilter debug or snapserver --logging.filter debug if possible and paste them in the following codeblock
With my normal options snapclient --user brian --player pulse:buffer_time=10 --host 192.168.0.13 --hostID arch-brian --logfilter debug:
2023-03-13 14-43-44.048 [Debug] (Snapclient) Trying to get PCM device for player: pulse, parameter: , card: default
2023-03-13 14-43-44.060 [Info] (Snapclient) Version 0.27.0
2023-03-13 14-43-44.060 [Info] (Connection) Resolving host IP for: 192.168.0.13
2023-03-13 14-43-44.060 [Info] (Connection) Connecting
2023-03-13 14-43-44.066 [Notice] (Connection) Connected to 192.168.0.13
2023-03-13 14-43-44.066 [Info] (Connection) My MAC: "70:85:c2:74:d2:a6", socket: 8
2023-03-13 14-43-44.096 [Debug] (Connection) outstanding async_write
2023-03-13 14-43-44.098 [Info] (Controller) ServerSettings - buffer: 200, latency: 0, volume: 100, muted: 0
2023-03-13 14-43-44.098 [Info] (Controller) Codec: flac, sampleformat: 48000:16:2
2023-03-13 14-43-44.098 [Info] (Player) Player name: pulse, device: default, description: Let PulseAudio server choose the device, idx: 273, sharing mode: unspecified, parameters: buffer_time=10
2023-03-13 14-43-44.098 [Info] (Player) Mixer mode: software, parameters: <none>
2023-03-13 14-43-44.098 [Info] (Player) Sampleformat: 48000:16:2, stream: 48000:16:2
2023-03-13 14-43-44.098 [Info] (PulsePlayer) Setting property "application.icon_name" to "snapcast"
2023-03-13 14-43-44.098 [Info] (PulsePlayer) Setting property "media.role" to "music"
2023-03-13 14-43-44.098 [Info] (PulsePlayer) Using buffer_time: 10 ms, server: default
2023-03-13 14-43-44.098 [Info] (PulsePlayer) Start
2023-03-13 14-43-44.098 [Info] (PulsePlayer) Connecting to pulse
2023-03-13 14-43-44.098 [Debug] (PulsePlayer) State changed 2: authorizing
2023-03-13 14-43-44.104 [Debug] (PulsePlayer) State changed 3: setting name
2023-03-13 14-43-44.107 [Debug] (PulsePlayer) State changed 4: ready
2023-03-13 14-43-44.108 [Debug] (Player) setVolume exp with base 10: 1 => 1
2023-03-13 14-43-44.285 [Info] (Controller) diff to server [ms]: 1.18967e+09
2023-03-13 14-43-44.340 [Debug] (Stream) age > 0: 62ms, dropping old chunks
2023-03-13 14-43-44.340 [Debug] (Stream) age: 38, requested chunk_duration: 11, duration: 24
2023-03-13 14-43-44.340 [Debug] (Stream) age: 14, requested chunk_duration: 11, duration: 24
2023-03-13 14-43-44.345 [Debug] (Stats) Chunk: 2 2 2 2 1 16 0
2023-03-13 14-43-44.484 [Info] (Stream) pMiniBuffer->full() && (abs(pMiniBuffer->mean()) > 50): 51785
2023-03-13 14-43-44.489 [Debug] (Stream) age > 0: 70ms, dropping old chunks
2023-03-13 14-43-44.489 [Debug] (Stream) age: 48, requested chunk_duration: 5, duration: 24
2023-03-13 14-43-44.489 [Debug] (Stream) age: 24, requested chunk_duration: 5, duration: 24
2023-03-13 14-43-44.489 [Debug] (Stream) age: 0, requested chunk_duration: 5, duration: 24
2023-03-13 14-43-44.601 [Info] (Stream) pMiniBuffer->full() && (abs(pMiniBuffer->mean()) > 50): 58567
2023-03-13 14-43-44.606 [Debug] (Stream) age > 0: 80ms, dropping old chunks
2023-03-13 14-43-44.606 [Debug] (Stream) age: 78, requested chunk_duration: 5, duration: 24
2023-03-13 14-43-44.606 [Debug] (Stream) age: 54, requested chunk_duration: 5, duration: 24
2023-03-13 14-43-44.607 [Debug] (Stream) age: 30, requested chunk_duration: 5, duration: 24
2023-03-13 14-43-44.607 [Debug] (Stream) age: 6, requested chunk_duration: 5, duration: 24
2023-03-13 14-43-44.692 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 207
2023-03-13 14-43-44.692 [Debug] (Stream) Failed to get chunk, returning silence
2023-03-13 14-43-44.697 [Debug] (Stream) age > 0: 1ms, dropping old chunks
2023-03-13 14-43-44.697 [Debug] (Stream) age: 1, requested chunk_duration: 5, duration: 24
2023-03-13 14-43-44.814 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 48
2023-03-13 14-43-44.836 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 177
2023-03-13 14-43-44.932 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 177
2023-03-13 14-43-45.172 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 177
2023-03-13 14-43-45.294 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 48
2023-03-13 14-43-45.316 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 175
2023-03-13 14-43-45.412 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 175
2023-03-13 14-43-45.534 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 47
2023-03-13 14-43-45.652 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 175
2023-03-13 14-43-45.774 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 41
2023-03-13 14-43-45.774 [Debug] (Stream) Failed to get chunk, returning silence
2023-03-13 14-43-45.780 [Debug] (Stream) age > 0: 4ms, dropping old chunks
2023-03-13 14-43-45.780 [Debug] (Stream) age: 4, requested chunk_duration: 5, duration: 24
2023-03-13 14-43-45.795 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 167
2023-03-13 14-43-45.892 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 168
2023-03-13 14-43-46.132 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 167
2023-03-13 14-43-46.254 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 38
2023-03-13 14-43-46.276 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 165
2023-03-13 14-43-46.372 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 164
2023-03-13 14-43-46.494 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 36
2023-03-13 14-43-46.612 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 163
2023-03-13 14-43-46.852 [Info] (Stream) Exception: Not enough frames available, requested frames: 256, available: 162
2023-03-13 14-43-46.852 [Debug] (Stream) Failed to get chunk, returning silence
2023-03-13 14-43-46.857 [Debug] (Stream) age > 0: 1ms, dropping old chunks
2023-03-13 14-43-46.857 [Debug] (Stream) age: 2, requested chunk_duration: 5, duration: 24
2023-03-13 14-43-47.006 [Debug] (Stats) Chunk: 1 1 1 1 28 168 0
^C2023-03-13 14-43-47.047 [Info] (Snapclient) Received signal 2: Interrupt
2023-03-13 14-43-47.047 [Debug] (PulsePlayer) Destructor
2023-03-13 14-43-47.047 [Info] (PulsePlayer) Stop
2023-03-13 14-43-47.047 [Info] (PulsePlayer) Disconnecting from pulse
2023-03-13 14-43-47.047 [Debug] (PulsePlayer) State changed 6: terminated
2023-03-13 14-43-47.148 [Debug] (PulsePlayer) Waiting for a chunk to become available before reconnecting
2023-03-13 14-43-47.148 [Debug] (Connection) Disconnecting
2023-03-13 14-43-47.148 [Debug] (Connection) Disconnected
2023-03-13 14-43-47.148 [Notice] (Snapclient) Snapclient terminated.
With fewest options snapclient --host 192.168.0.13 --hostID arch-brian --logfilter debug > out.txt:
2023-03-13 14-42-53.631 [Debug] (Snapclient) Trying to get PCM device for player: alsa, parameter: , card: default
2023-03-13 14-42-53.639 [Info] (Snapclient) Version 0.27.0
2023-03-13 14-42-53.639 [Info] (Connection) Resolving host IP for: 192.168.0.13
2023-03-13 14-42-53.639 [Info] (Connection) Connecting
2023-03-13 14-42-53.647 [Notice] (Connection) Connected to 192.168.0.13
2023-03-13 14-42-53.647 [Info] (Connection) My MAC: "70:85:c2:74:d2:a6", socket: 8
2023-03-13 14-42-53.669 [Debug] (Connection) outstanding async_write
2023-03-13 14-42-53.672 [Info] (Controller) ServerSettings - buffer: 200, latency: 0, volume: 100, muted: 0
2023-03-13 14-42-53.674 [Info] (Controller) Codec: flac, sampleformat: 48000:16:2
2023-03-13 14-42-53.674 [Info] (Player) Player name: alsa, device: default, description: Default ALSA Output (currently PipeWire Media Server), idx: 11, sharing mode: unspecified, parameters: <none>
2023-03-13 14-42-53.674 [Info] (Player) Mixer mode: software, parameters: <none>
2023-03-13 14-42-53.674 [Info] (Player) Sampleformat: 48000:16:2, stream: 48000:16:2
2023-03-13 14-42-53.674 [Info] (Alsa) Using default buffer_time: 80 ms, default fragments: 4
2023-03-13 14-42-53.689 [Debug] (Alsa) ACCESS: MMAP_INTERLEAVED MMAP_NONINTERLEAVED RW_INTERLEAVED RW_NONINTERLEAVED
2023-03-13 14-42-53.689 [Debug] (Alsa) FORMAT: U8 S16_LE S24_LE S32_LE FLOAT_LE S24_3LE S24_3BE
2023-03-13 14-42-53.689 [Debug] (Alsa) SUBFORMAT: STD
2023-03-13 14-42-53.689 [Debug] (Alsa) SAMPLE_BITS: [8 32]
2023-03-13 14-42-53.689 [Debug] (Alsa) FRAME_BITS: [8 2048]
2023-03-13 14-42-53.689 [Debug] (Alsa) CHANNELS: [1 64]
2023-03-13 14-42-53.689 [Debug] (Alsa) RATE: [1 384000]
2023-03-13 14-42-53.689 [Debug] (Alsa) PERIOD_TIME: (0 4294967295)
2023-03-13 14-42-53.689 [Debug] (Alsa) PERIOD_SIZE: (0 2097152]
2023-03-13 14-42-53.689 [Debug] (Alsa) PERIOD_BYTES: [128 2097152]
2023-03-13 14-42-53.689 [Debug] (Alsa) PERIODS: [2 1024]
2023-03-13 14-42-53.689 [Debug] (Alsa) BUFFER_TIME: (2 4294967295]
2023-03-13 14-42-53.689 [Debug] (Alsa) BUFFER_SIZE: [1 4194304]
2023-03-13 14-42-53.689 [Debug] (Alsa) BUFFER_BYTES: [256 4194304]
2023-03-13 14-42-53.689 [Debug] (Alsa) TICK_TIME: ALL
2023-03-13 14-42-53.690 [Info] (Alsa) PCM name: ALSA Playback, sample rate: 48000 Hz, channels: 2, buffer time: 80000 us, periods: 4, period time: 20000 us, period frames: 960
2023-03-13 14-42-53.691 [Debug] (Alsa) setVolume exp with base 10: 1 => 1
2023-03-13 14-42-53.691 [Debug] (Alsa) Resizing buffer from 0 to 15360
2023-03-13 14-42-53.691 [Info] (Stream) No chunks available
2023-03-13 14-42-53.691 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-53.880 [Info] (Stream) outputBufferDacTime > bufferMs: 200 > 200
2023-03-13 14-42-53.880 [Info] (Alsa) Failed to get chunk
This two line are repeated more than 3200 times!
2023-03-13 14-42-53.880 [Info] (Stream) outputBufferDacTime > bufferMs: 200 > 200
2023-03-13 14-42-53.880 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-53.880 [Debug] (Stream) age > 0: 217ms, dropping old chunks
2023-03-13 14-42-53.880 [Debug] (Stream) age: 193, requested chunk_duration: 42, duration: 24
2023-03-13 14-42-53.880 [Debug] (Stream) age: 169, requested chunk_duration: 42, duration: 24
2023-03-13 14-42-53.880 [Debug] (Stream) age: 145, requested chunk_duration: 42, duration: 24
2023-03-13 14-42-53.880 [Debug] (Stream) age: 121, requested chunk_duration: 42, duration: 24
2023-03-13 14-42-53.880 [Debug] (Stream) age: 97, requested chunk_duration: 42, duration: 24
2023-03-13 14-42-53.880 [Debug] (Stream) age: 73, requested chunk_duration: 42, duration: 24
2023-03-13 14-42-53.880 [Debug] (Stream) age: 49, requested chunk_duration: 42, duration: 24
2023-03-13 14-42-53.880 [Debug] (Stream) age: 25, requested chunk_duration: 42, duration: 24
2023-03-13 14-42-53.880 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-53.894 [Debug] (Stream) age > 0: 25ms, dropping old chunks
2023-03-13 14-42-53.894 [Debug] (Stream) age: 1, requested chunk_duration: 64, duration: 24
2023-03-13 14-42-53.894 [Info] (Stream) Exception: Not enough frames available, requested frames: 3072, available: 1096
2023-03-13 14-42-53.894 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-53.914 [Info] (Controller) diff to server [ms]: 1.18967e+09
2023-03-13 14-42-53.933 [Warn] (Alsa) snd_pcm_avail_delay failed: Broken pipe (-32), avail: 3072, delay: 8916, using snd_pcm_avail amd snd_pcm_delay.
2023-03-13 14-42-53.935 [Debug] (Alsa) snd_pcm_avail failed: Broken pipe (-32), using 960
2023-03-13 14-42-53.935 [Debug] (Stream) age > 0: 3ms, dropping old chunks
2023-03-13 14-42-53.935 [Debug] (Stream) age: 3, requested chunk_duration: 20, duration: 24
2023-03-13 14-42-53.935 [Error] (Alsa) XRUN while writing to PCM: Broken pipe
2023-03-13 14-42-53.935 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 41
2023-03-13 14-42-53.935 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-53.954 [Debug] (Stream) Silent frames: 53, frames: 3840, age: -1.109
2023-03-13 14-42-53.954 [Info] (Stream) Exception: Not enough frames available, requested frames: 3787, available: 1152
2023-03-13 14-42-53.954 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-53.974 [Debug] (Stream) Silent frames: 284, frames: 3840, age: -5.924
2023-03-13 14-42-53.974 [Info] (Stream) Exception: Not enough frames available, requested frames: 3556, available: 1152
2023-03-13 14-42-53.974 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-53.994 [Debug] (Stream) Silent frames: 455, frames: 3840, age: -9.48
2023-03-13 14-42-53.994 [Info] (Stream) Exception: Not enough frames available, requested frames: 3385, available: 1152
2023-03-13 14-42-53.994 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.014 [Debug] (Stream) Silent frames: 667, frames: 3840, age: -13.901
2023-03-13 14-42-54.014 [Info] (Stream) Exception: Not enough frames available, requested frames: 3173, available: 1152
2023-03-13 14-42-54.014 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.053 [Debug] (Stream) age > 0: 2ms, dropping old chunks
2023-03-13 14-42-54.054 [Debug] (Stream) age: 2, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-54.054 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 1052
2023-03-13 14-42-54.054 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.074 [Debug] (Stream) Silent frames: 64, frames: 3840, age: -1.351
2023-03-13 14-42-54.074 [Info] (Stream) Exception: Not enough frames available, requested frames: 3776, available: 1152
2023-03-13 14-42-54.074 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.094 [Debug] (Stream) Silent frames: 272, frames: 3840, age: -5.672
2023-03-13 14-42-54.094 [Info] (Stream) Exception: Not enough frames available, requested frames: 3568, available: 1152
2023-03-13 14-42-54.094 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.114 [Debug] (Stream) Silent frames: 453, frames: 3840, age: -9.438
2023-03-13 14-42-54.114 [Info] (Stream) Exception: Not enough frames available, requested frames: 3387, available: 1152
2023-03-13 14-42-54.114 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.134 [Debug] (Stream) Silent frames: 659, frames: 3840, age: -13.731
2023-03-13 14-42-54.134 [Info] (Stream) Exception: Not enough frames available, requested frames: 3181, available: 1152
2023-03-13 14-42-54.134 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.175 [Debug] (Stream) age > 0: 3ms, dropping old chunks
2023-03-13 14-42-54.175 [Debug] (Stream) age: 3, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-54.175 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 989
2023-03-13 14-42-54.175 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.193 [Debug] (Stream) Silent frames: 126, frames: 3840, age: -2.643
2023-03-13 14-42-54.193 [Info] (Stream) Exception: Not enough frames available, requested frames: 3714, available: 1152
2023-03-13 14-42-54.193 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.215 [Debug] (Stream) Silent frames: 235, frames: 3840, age: -4.903
2023-03-13 14-42-54.215 [Info] (Stream) Exception: Not enough frames available, requested frames: 3605, available: 1152
2023-03-13 14-42-54.215 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.234 [Debug] (Stream) Silent frames: 435, frames: 3840, age: -9.08
2023-03-13 14-42-54.235 [Info] (Stream) Exception: Not enough frames available, requested frames: 3405, available: 1152
2023-03-13 14-42-54.235 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.254 [Debug] (Stream) Silent frames: 644, frames: 3840, age: -13.436
2023-03-13 14-42-54.254 [Info] (Stream) Exception: Not enough frames available, requested frames: 3196, available: 1152
2023-03-13 14-42-54.254 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.293 [Debug] (Stream) age > 0: 1ms, dropping old chunks
2023-03-13 14-42-54.293 [Debug] (Stream) age: 1, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-54.293 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 1078
2023-03-13 14-42-54.293 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.314 [Debug] (Stream) Silent frames: 73, frames: 3840, age: -1.526
2023-03-13 14-42-54.314 [Info] (Stream) Exception: Not enough frames available, requested frames: 3767, available: 1152
2023-03-13 14-42-54.314 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.334 [Debug] (Stream) Silent frames: 286, frames: 3840, age: -5.964
2023-03-13 14-42-54.334 [Info] (Stream) Exception: Not enough frames available, requested frames: 3554, available: 1152
2023-03-13 14-42-54.334 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.353 [Debug] (Stream) Silent frames: 488, frames: 3840, age: -10.171
2023-03-13 14-42-54.353 [Info] (Stream) Exception: Not enough frames available, requested frames: 3352, available: 1152
2023-03-13 14-42-54.353 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.373 [Debug] (Stream) Silent frames: 704, frames: 3840, age: -14.682
2023-03-13 14-42-54.373 [Info] (Stream) Exception: Not enough frames available, requested frames: 3136, available: 1152
2023-03-13 14-42-54.373 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.415 [Debug] (Stream) age > 0: 3ms, dropping old chunks
2023-03-13 14-42-54.415 [Debug] (Stream) age: 3, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-54.415 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 987
2023-03-13 14-42-54.415 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.433 [Debug] (Stream) Silent frames: 117, frames: 3840, age: -2.445
2023-03-13 14-42-54.433 [Info] (Stream) Exception: Not enough frames available, requested frames: 3723, available: 1152
2023-03-13 14-42-54.433 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.453 [Debug] (Stream) Silent frames: 320, frames: 3840, age: -6.672
2023-03-13 14-42-54.453 [Info] (Stream) Exception: Not enough frames available, requested frames: 3520, available: 1152
2023-03-13 14-42-54.453 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.474 [Debug] (Stream) Silent frames: 451, frames: 3840, age: -9.413
2023-03-13 14-42-54.474 [Info] (Stream) Exception: Not enough frames available, requested frames: 3389, available: 1152
2023-03-13 14-42-54.474 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.494 [Debug] (Stream) Silent frames: 668, frames: 3840, age: -13.926
2023-03-13 14-42-54.494 [Info] (Stream) Exception: Not enough frames available, requested frames: 3172, available: 1152
2023-03-13 14-42-54.494 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.533 [Debug] (Stream) age > 0: 1ms, dropping old chunks
2023-03-13 14-42-54.533 [Debug] (Stream) age: 1, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-54.533 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 1065
2023-03-13 14-42-54.533 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.553 [Debug] (Stream) Silent frames: 98, frames: 3840, age: -2.06
2023-03-13 14-42-54.554 [Info] (Stream) Exception: Not enough frames available, requested frames: 3742, available: 1152
2023-03-13 14-42-54.554 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.574 [Debug] (Stream) Silent frames: 246, frames: 3840, age: -5.142
2023-03-13 14-42-54.574 [Info] (Stream) Exception: Not enough frames available, requested frames: 3594, available: 1152
2023-03-13 14-42-54.574 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.595 [Debug] (Stream) Silent frames: 430, frames: 3840, age: -8.963
2023-03-13 14-42-54.595 [Info] (Stream) Exception: Not enough frames available, requested frames: 3410, available: 1152
2023-03-13 14-42-54.595 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.613 [Debug] (Stream) Silent frames: 696, frames: 3840, age: -14.519
2023-03-13 14-42-54.613 [Info] (Stream) Exception: Not enough frames available, requested frames: 3144, available: 1152
2023-03-13 14-42-54.613 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.654 [Debug] (Stream) age > 0: 2ms, dropping old chunks
2023-03-13 14-42-54.654 [Debug] (Stream) age: 2, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-54.654 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 1032
2023-03-13 14-42-54.654 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.675 [Debug] (Stream) Silent frames: 33, frames: 3840, age: -0.689
2023-03-13 14-42-54.675 [Info] (Stream) Exception: Not enough frames available, requested frames: 3807, available: 1152
2023-03-13 14-42-54.675 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.694 [Debug] (Stream) Silent frames: 262, frames: 3840, age: -5.462
2023-03-13 14-42-54.694 [Info] (Stream) Exception: Not enough frames available, requested frames: 3578, available: 1152
2023-03-13 14-42-54.694 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.713 [Debug] (Stream) Silent frames: 509, frames: 3840, age: -10.605
2023-03-13 14-42-54.713 [Info] (Stream) Exception: Not enough frames available, requested frames: 3331, available: 1152
2023-03-13 14-42-54.713 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.734 [Debug] (Stream) Silent frames: 637, frames: 3840, age: -13.278
2023-03-13 14-42-54.734 [Info] (Stream) Exception: Not enough frames available, requested frames: 3203, available: 1152
2023-03-13 14-42-54.734 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.774 [Debug] (Stream) age > 0: 2ms, dropping old chunks
2023-03-13 14-42-54.774 [Debug] (Stream) age: 2, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-54.774 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 1038
2023-03-13 14-42-54.774 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.797 [Debug] (Stream) age > 0: 1ms, dropping old chunks
2023-03-13 14-42-54.797 [Debug] (Stream) age: 2, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-54.798 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 1056
2023-03-13 14-42-54.798 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.815 [Debug] (Stream) Silent frames: 229, frames: 3840, age: -4.787
2023-03-13 14-42-54.815 [Info] (Stream) Exception: Not enough frames available, requested frames: 3611, available: 1152
2023-03-13 14-42-54.815 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.834 [Debug] (Stream) Silent frames: 464, frames: 3840, age: -9.678
2023-03-13 14-42-54.834 [Info] (Stream) Exception: Not enough frames available, requested frames: 3376, available: 1152
2023-03-13 14-42-54.834 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.854 [Debug] (Stream) Silent frames: 667, frames: 3840, age: -13.898
2023-03-13 14-42-54.854 [Info] (Stream) Exception: Not enough frames available, requested frames: 3173, available: 1152
2023-03-13 14-42-54.854 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.894 [Debug] (Stream) age > 0: 2ms, dropping old chunks
2023-03-13 14-42-54.894 [Debug] (Stream) age: 2, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-54.894 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 1038
2023-03-13 14-42-54.894 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.913 [Debug] (Stream) Silent frames: 130, frames: 3840, age: -2.728
2023-03-13 14-42-54.913 [Info] (Stream) Exception: Not enough frames available, requested frames: 3710, available: 1152
2023-03-13 14-42-54.913 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.933 [Debug] (Stream) Silent frames: 294, frames: 3840, age: -6.138
2023-03-13 14-42-54.933 [Info] (Stream) Exception: Not enough frames available, requested frames: 3546, available: 1152
2023-03-13 14-42-54.934 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.954 [Debug] (Stream) Silent frames: 431, frames: 3840, age: -8.997
2023-03-13 14-42-54.955 [Info] (Stream) Exception: Not enough frames available, requested frames: 3409, available: 1152
2023-03-13 14-42-54.955 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-54.973 [Debug] (Stream) Silent frames: 672, frames: 3840, age: -14.015
2023-03-13 14-42-54.974 [Info] (Stream) Exception: Not enough frames available, requested frames: 3168, available: 1152
2023-03-13 14-42-54.974 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.013 [Debug] (Stream) age > 0: 1ms, dropping old chunks
2023-03-13 14-42-55.013 [Debug] (Stream) age: 1, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-55.013 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 1083
2023-03-13 14-42-55.013 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.034 [Debug] (Stream) Silent frames: 78, frames: 3840, age: -1.645
2023-03-13 14-42-55.034 [Info] (Stream) Exception: Not enough frames available, requested frames: 3762, available: 1152
2023-03-13 14-42-55.034 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.053 [Debug] (Stream) Silent frames: 315, frames: 3840, age: -6.58
2023-03-13 14-42-55.053 [Info] (Stream) Exception: Not enough frames available, requested frames: 3525, available: 1152
2023-03-13 14-42-55.053 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.073 [Debug] (Stream) Silent frames: 483, frames: 3840, age: -10.066
2023-03-13 14-42-55.074 [Info] (Stream) Exception: Not enough frames available, requested frames: 3357, available: 1152
2023-03-13 14-42-55.074 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.094 [Debug] (Stream) Silent frames: 638, frames: 3840, age: -13.302
2023-03-13 14-42-55.094 [Info] (Stream) Exception: Not enough frames available, requested frames: 3202, available: 1152
2023-03-13 14-42-55.094 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.133 [Debug] (Stream) age > 0: 1ms, dropping old chunks
2023-03-13 14-42-55.134 [Debug] (Stream) age: 2, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-55.134 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 1053
2023-03-13 14-42-55.134 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.153 [Debug] (Stream) Silent frames: 122, frames: 3840, age: -2.551
2023-03-13 14-42-55.153 [Info] (Stream) Exception: Not enough frames available, requested frames: 3718, available: 1152
2023-03-13 14-42-55.153 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.174 [Debug] (Stream) Silent frames: 250, frames: 3840, age: -5.223
2023-03-13 14-42-55.174 [Info] (Stream) Exception: Not enough frames available, requested frames: 3590, available: 1152
2023-03-13 14-42-55.174 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.197 [Debug] (Stream) Silent frames: 293, frames: 3840, age: -6.116
2023-03-13 14-42-55.197 [Info] (Stream) Exception: Not enough frames available, requested frames: 3547, available: 1152
2023-03-13 14-42-55.198 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.214 [Debug] (Stream) Silent frames: 641, frames: 3840, age: -13.367
2023-03-13 14-42-55.214 [Info] (Stream) Exception: Not enough frames available, requested frames: 3199, available: 1152
2023-03-13 14-42-55.214 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.254 [Debug] (Stream) age > 0: 2ms, dropping old chunks
2023-03-13 14-42-55.254 [Debug] (Stream) age: 2, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-55.254 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 1035
2023-03-13 14-42-55.254 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.274 [Debug] (Stream) Silent frames: 78, frames: 3840, age: -1.635
2023-03-13 14-42-55.274 [Info] (Stream) Exception: Not enough frames available, requested frames: 3762, available: 1152
2023-03-13 14-42-55.274 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.294 [Debug] (Stream) Silent frames: 242, frames: 3840, age: -5.052
2023-03-13 14-42-55.294 [Info] (Stream) Exception: Not enough frames available, requested frames: 3598, available: 1152
2023-03-13 14-42-55.294 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.314 [Debug] (Stream) Silent frames: 471, frames: 3840, age: -9.817
2023-03-13 14-42-55.314 [Info] (Stream) Exception: Not enough frames available, requested frames: 3369, available: 1152
2023-03-13 14-42-55.314 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.334 [Debug] (Stream) Silent frames: 662, frames: 3840, age: -13.802
2023-03-13 14-42-55.334 [Info] (Stream) Exception: Not enough frames available, requested frames: 3178, available: 1152
2023-03-13 14-42-55.334 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.373 [Debug] (Stream) age > 0: 1ms, dropping old chunks
2023-03-13 14-42-55.373 [Debug] (Stream) age: 1, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-55.373 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 1062
2023-03-13 14-42-55.373 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.394 [Debug] (Stream) Silent frames: 77, frames: 3840, age: -1.624
2023-03-13 14-42-55.394 [Info] (Stream) Exception: Not enough frames available, requested frames: 3763, available: 1152
2023-03-13 14-42-55.394 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.413 [Debug] (Stream) Silent frames: 298, frames: 3840, age: -6.215
2023-03-13 14-42-55.413 [Info] (Stream) Exception: Not enough frames available, requested frames: 3542, available: 1152
2023-03-13 14-42-55.413 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.434 [Debug] (Stream) Silent frames: 462, frames: 3840, age: -9.633
2023-03-13 14-42-55.434 [Info] (Stream) Exception: Not enough frames available, requested frames: 3378, available: 1152
2023-03-13 14-42-55.434 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.453 [Debug] (Stream) Silent frames: 676, frames: 3840, age: -14.096
2023-03-13 14-42-55.454 [Info] (Stream) Exception: Not enough frames available, requested frames: 3164, available: 1152
2023-03-13 14-42-55.454 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.492 [Debug] (Stream) age > 0: 0ms, dropping old chunks
2023-03-13 14-42-55.492 [Debug] (Stream) age: 0, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-55.492 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 1107
2023-03-13 14-42-55.493 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.512 [Debug] (Stream) Silent frames: 150, frames: 3840, age: -3.138
2023-03-13 14-42-55.512 [Info] (Stream) Exception: Not enough frames available, requested frames: 3690, available: 1152
2023-03-13 14-42-55.513 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.532 [Debug] (Stream) Silent frames: 342, frames: 3840, age: -7.137
2023-03-13 14-42-55.532 [Info] (Stream) Exception: Not enough frames available, requested frames: 3498, available: 1152
2023-03-13 14-42-55.533 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.554 [Debug] (Stream) Silent frames: 456, frames: 3840, age: -9.504
2023-03-13 14-42-55.554 [Info] (Stream) Exception: Not enough frames available, requested frames: 3384, available: 1152
2023-03-13 14-42-55.554 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.572 [Debug] (Stream) Silent frames: 726, frames: 3840, age: -15.143
2023-03-13 14-42-55.572 [Info] (Stream) Exception: Not enough frames available, requested frames: 3114, available: 1152
2023-03-13 14-42-55.572 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.613 [Debug] (Stream) age > 0: 1ms, dropping old chunks
2023-03-13 14-42-55.613 [Debug] (Stream) age: 1, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-55.613 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 1059
2023-03-13 14-42-55.614 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.632 [Debug] (Stream) Silent frames: 148, frames: 3840, age: -3.104
2023-03-13 14-42-55.633 [Info] (Stream) Exception: Not enough frames available, requested frames: 3692, available: 1152
2023-03-13 14-42-55.633 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.654 [Debug] (Stream) Silent frames: 274, frames: 3840, age: -5.715
2023-03-13 14-42-55.654 [Info] (Stream) Exception: Not enough frames available, requested frames: 3566, available: 1152
2023-03-13 14-42-55.654 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.674 [Debug] (Stream) Silent frames: 436, frames: 3840, age: -9.085
2023-03-13 14-42-55.675 [Info] (Stream) Exception: Not enough frames available, requested frames: 3404, available: 1152
2023-03-13 14-42-55.675 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.693 [Debug] (Stream) Silent frames: 674, frames: 3840, age: -14.049
2023-03-13 14-42-55.694 [Info] (Stream) Exception: Not enough frames available, requested frames: 3166, available: 1152
2023-03-13 14-42-55.694 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.733 [Debug] (Stream) age > 0: 1ms, dropping old chunks
2023-03-13 14-42-55.733 [Debug] (Stream) age: 2, requested chunk_duration: 80, duration: 24
2023-03-13 14-42-55.734 [Info] (Stream) Exception: Not enough frames available, requested frames: 3840, available: 1055
2023-03-13 14-42-55.734 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.754 [Debug] (Stream) Silent frames: 80, frames: 3840, age: -1.675
2023-03-13 14-42-55.754 [Info] (Stream) Exception: Not enough frames available, requested frames: 3760, available: 1152
2023-03-13 14-42-55.754 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.774 [Debug] (Stream) Silent frames: 240, frames: 3840, age: -5.002
2023-03-13 14-42-55.775 [Info] (Stream) Exception: Not enough frames available, requested frames: 3600, available: 1152
2023-03-13 14-42-55.775 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.794 [Debug] (Stream) Silent frames: 465, frames: 3840, age: -9.691
2023-03-13 14-42-55.794 [Info] (Stream) Exception: Not enough frames available, requested frames: 3375, available: 1152
2023-03-13 14-42-55.794 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.814 [Debug] (Stream) Silent frames: 653, frames: 3840, age: -13.612
2023-03-13 14-42-55.814 [Info] (Stream) Exception: Not enough frames available, requested frames: 3187, available: 1152
2023-03-13 14-42-55.814 [Info] (Alsa) Failed to get chunk
2023-03-13 14-42-55.827 [Info] (Snapclient) Received signal 2: Interrupt
2023-03-13 14-42-55.914 [Debug] (Alsa) Waiting for chunk
2023-03-13 14-42-55.917 [Debug] (Connection) Disconnecting
2023-03-13 14-42-55.917 [Debug] (Connection) Disconnected
2023-03-13 14-42-55.917 [Notice] (Snapclient) Snapclient terminated.
But it is working kind of flawlessly if bluetooth is not the audio output snapclient ----user brian --player pulse:buffer_time=10 --host 192.168.0.13 --hostID arch-brian --logfilter debug:
2023-03-13 14-44-56.332 [Debug] (Snapclient) Trying to get PCM device for player: pulse, parameter: , card: default
2023-03-13 14-44-56.344 [Info] (Snapclient) Version 0.27.0
2023-03-13 14-44-56.344 [Info] (Connection) Resolving host IP for: 192.168.0.13
2023-03-13 14-44-56.344 [Info] (Connection) Connecting
2023-03-13 14-44-56.346 [Notice] (Connection) Connected to 192.168.0.13
2023-03-13 14-44-56.346 [Info] (Connection) My MAC: "70:85:c2:74:d2:a6", socket: 8
2023-03-13 14-44-56.370 [Debug] (Connection) outstanding async_write
2023-03-13 14-44-56.372 [Info] (Controller) ServerSettings - buffer: 200, latency: 0, volume: 100, muted: 0
2023-03-13 14-44-56.373 [Info] (Controller) Codec: flac, sampleformat: 48000:16:2
2023-03-13 14-44-56.373 [Info] (Player) Player name: pulse, device: default, description: Let PulseAudio server choose the device, idx: 45, sharing mode: unspecified, parameters: buffer_time=10
2023-03-13 14-44-56.373 [Info] (Player) Mixer mode: software, parameters: <none>
2023-03-13 14-44-56.373 [Info] (Player) Sampleformat: 48000:16:2, stream: 48000:16:2
2023-03-13 14-44-56.373 [Info] (PulsePlayer) Setting property "application.icon_name" to "snapcast"
2023-03-13 14-44-56.373 [Info] (PulsePlayer) Setting property "media.role" to "music"
2023-03-13 14-44-56.373 [Info] (PulsePlayer) Using buffer_time: 10 ms, server: default
2023-03-13 14-44-56.373 [Info] (PulsePlayer) Start
2023-03-13 14-44-56.373 [Info] (PulsePlayer) Connecting to pulse
2023-03-13 14-44-56.373 [Debug] (PulsePlayer) State changed 2: authorizing
2023-03-13 14-44-56.379 [Debug] (PulsePlayer) State changed 3: setting name
2023-03-13 14-44-56.383 [Debug] (PulsePlayer) State changed 4: ready
2023-03-13 14-44-56.385 [Debug] (Player) setVolume exp with base 10: 1 => 1
2023-03-13 14-44-56.530 [Debug] (Stream) Silent frames: 47, frames: 256, age: -0.999
2023-03-13 14-44-56.535 [Debug] (Stats) Chunk: 0 0 0 0 1 20 0
2023-03-13 14-44-56.560 [Info] (Controller) diff to server [ms]: 1.18967e+09
2023-03-13 14-44-57.005 [Debug] (Stats) Chunk: -10 -9 -6 -6 89 19 0
2023-03-13 14-44-58.007 [Debug] (Stats) Chunk: -58 -56 -49 -25 277 14 13
2023-03-13 14-44-59.005 [Debug] (Stats) Chunk: -82 -82 -81 -50 464 11 24
2023-03-13 14-44-59.010 [Info] (Stream) pShortBuffer->full() && (abs(shortMedian_) > 5): -8161
2023-03-13 14-44-59.021 [Debug] (Stream) Silent frames: 141, frames: 256, age: -2.958
2023-03-13 14-44-59.559 [Info] (Stream) pShortBuffer->full() && (abs(shortMedian_) > 5): -8161
2023-03-13 14-44-59.565 [Debug] (Stream) Silent frames: 91, frames: 256, age: -1.903
2023-03-13 14-45-00.002 [Debug] (Stats) Chunk: -15 -13 -7 -7 82 8 0
2023-03-13 14-45-01.005 [Debug] (Stats) Chunk: -3 -2 2 -5 270 9 7
2023-03-13 14-45-02.002 [Debug] (Stats) Chunk: 45 26 -20 -10 457 14 0
2023-03-13 14-45-03.005 [Debug] (Stats) Chunk: 29 30 34 3 500 12 0
2023-03-13 14-45-04.002 [Debug] (Stats) Chunk: 42 43 46 34 500 14 -24
2023-03-13 14-45-04.007 [Info] (Stream) pBuffer->full() && (abs(median_) > 2): 3414
2023-03-13 14-45-04.013 [Debug] (Stream) age > 0: 4ms, dropping old chunks
2023-03-13 14-45-04.013 [Debug] (Stream) age: -12, requested chunk_duration: 5, duration: 24
2023-03-13 14-45-04.013 [Debug] (Stream) Silent frames: 256, frames: 256, age: -12.604
2023-03-13 14-45-04.023 [Debug] (Stream) Silent frames: 96, frames: 256, age: -2.008
2023-03-13 14-45-05.005 [Debug] (Stats) Chunk: 16 16 -7 -5 184 15 0
2023-03-13 14-45-06.002 [Debug] (Stats) Chunk: 8 9 10 9 371 15 0
2023-03-13 14-45-07.005 [Debug] (Stats) Chunk: 23 24 26 10 500 17 -24
2023-03-13 14-45-08.002 [Debug] (Stats) Chunk: 38 38 17 16 500 19 -24
2023-03-13 14-45-09.005 [Debug] (Stats) Chunk: 31 31 33 26 500 18 -24
2023-03-13 14-45-09.010 [Info] (Stream) pBuffer->full() && (abs(median_) > 2): 2653
2023-03-13 14-45-09.015 [Debug] (Stream) age > 0: 3ms, dropping old chunks
2023-03-13 14-45-09.015 [Debug] (Stream) age: 2, requested chunk_duration: 5, duration: 24
^C2023-03-13 14-45-09.432 [Info] (Snapclient) Received signal 2: Interrupt
2023-03-13 14-45-09.432 [Debug] (PulsePlayer) Destructor
2023-03-13 14-45-09.432 [Info] (PulsePlayer) Stop
2023-03-13 14-45-09.432 [Info] (PulsePlayer) Disconnecting from pulse
2023-03-13 14-45-09.432 [Debug] (PulsePlayer) State changed 6: terminated
2023-03-13 14-45-09.432 [Info] (PulsePlayer) Chunk available, reconnecting to pulse
2023-03-13 14-45-09.432 [Info] (PulsePlayer) Connecting to pulse
2023-03-13 14-45-09.433 [Debug] (PulsePlayer) State changed 2: authorizing
2023-03-13 14-45-09.439 [Debug] (PulsePlayer) State changed 3: setting name
2023-03-13 14-45-09.446 [Debug] (PulsePlayer) State changed 4: ready
2023-03-13 14-45-09.447 [Debug] (Connection) Disconnecting
2023-03-13 14-45-09.447 [Debug] (Connection) Disconnected
2023-03-13 14-45-09.448 [Notice] (Snapclient) Snapclient terminated.
