Login

fdealexa · (This post was last modified: 02-15-2023, 10:45 PM by fdealexa.)

(02-15-2023, 05:33 PM)Tim Curtis Wrote:
(02-15-2023, 05:15 PM)fdealexa Wrote:
(09-16-2022, 04:40 PM)TheOldPresbyope Wrote: Ah, finally.

Radio Calico just went silent in the midst of a song. Checking the MPD log at /var/log/MPD/log I see a succession of underrun messages

Code:
pi@m820pre1:~ $ tail -f /var/log/mpd/log Sep 16 12:30 : alsa_output: Decoder is too slow; playing silence to avoid xrun Sep 16 12:30 : alsa_output: Decoder is too slow; playing silence to avoid xrun ...

Further, the station IP doesn't even return a ping now. That's due to the station itself or to some upstream network problem. Nothing moOde can do about it.

Regards,
Kent

Hi Kent, hi everyone,
I have a similar problem on several FLAC radio stations, so I've been looking into it. In particular, there is a station that reports an anomaly every 30 seconds and I have to stop and play again (the error reported on the log is: (alsa_output: Decoder is too slow; playing silence to avoid xrun). I excluded that it could be network problems: I tried to decode on PC with different players (VLC, FOOBAR, directly with the BROWSER) and I never encountered the problem. So I decided to try and check by excluding the whole moOde supply chain, trying to use the browser on the same raspberry: it does not block.
Doing a search on the type of error I found a hypothetical solution: add the following parameters to each "audio output" in the "mpd" configuration (/etc/mpd.conf)
buffer_time "200000"
period_time "5084"
I tried it, without doing the "reboot" but only with the "restart" of "mpd", but without success.
I believe the problem may be related to receiving strange metadata, this is confirmed by the fact that some other stations freeze when changing tracks. What is your opinion? What do you think about it? Do you have any other advice?

The station is https://stream.and-stuff.nl:8443/riverside

Thanks in advance and regards
Francesco

Try setting just the buffer_time to 200000 and let MPD calculate period_time. The resulting period_time reported in MPD verbose log should be buffer_time / 4.

Code:
Feb 15 12:31 : alsa_output: default period_time = buffer_time/4 = 200000/4 = 50000

Hello Tim,
thank you very much for you prompt reply.
Unfortunatly I have tryed but the result is the same.
Please find below some notes:

Code:
pi@moOde-FdA-Test:~ $ cat /etc/mpd.conf

#########################################

# This file is automatically generated

# by the MPD configuration page.

#########################################

music_directory "/var/lib/mpd/music"

playlist_directory "/var/lib/mpd/playlists"

db_file "/var/lib/mpd/database"

log_file "/var/log/mpd/log"

pid_file "/var/run/mpd/pid"

state_file "/var/lib/mpd/state"

sticker_file "/var/lib/mpd/sticker.sql"

user "mpd"

group "audio"

bind_to_address "any"

port "6600"

log_level "verbose"

restore_paused "yes"

auto_update "no"

follow_outside_symlinks "yes"

follow_inside_symlinks "yes"

zeroconf_enabled "no"

zeroconf_name "Moode MPD"

filesystem_charset "UTF-8"

metadata_to_use "+comment"

replaygain "off"

replaygain_preamp "0"

volume_normalization "no"

audio_buffer_size "4096"

max_output_buffer_size "131072"

max_playlist_length "16384"

max_connections "128"

decoder {

plugin "ffmpeg"

enabled "yes"

}

input {

plugin "curl"

}

resampler {

plugin "soxr"

quality "high"

threads "1"

}

audio_output {

type "alsa"

name "ALSA Default"

device "_audioout"

mixer_type "software"

dop "no"

stop_dsd_silence "no"

thesycon_dsd_workaround "no"

buffer_time "200000"

}

audio_output {

type "alsa"

name "ALSA Bluetooth"

device "_audioout"

mixer_type "software"

buffer_time "200000"

}

please note that the changed parameter has been accepted but the result is the same every 30 sec it gives the issue and I have to stop and play again.

Code:
pi@moOde-FdA-Test:~ $ tail -f /var/log/mpd/log

Feb 15 23:34 : client: [35] command returned 0

Feb 15 23:34 : client: [35] process command "close"

Feb 15 23:34 : client: [35] command returned 4

Feb 15 23:34 : client: [35] closed

Feb 15 23:34 : client: [36] opened from 127.0.0.1:59382

Feb 15 23:34 : client: [36] process command "playlistinfo"

Feb 15 23:34 : client: [36] command returned 0

Feb 15 23:34 : client: [36] process command "close"

Feb 15 23:34 : client: [36] command returned 4

Feb 15 23:34 : client: [36] closed

Feb 15 23:36 : state_file: Saving state file /var/lib/mpd/state

Feb 15 23:36 : client: [37] opened from 127.0.0.1:36840

Feb 15 23:36 : client: [37] process command "play"

Feb 15 23:36 : playlist: play 1:"https://stream.and-stuff.nl:8443/riverside"

Feb 15 23:36 : client: [37] command returned 0

Feb 15 23:36 : client: [37] process command "close"

Feb 15 23:36 : client: [37] command returned 4

Feb 15 23:36 : client: [37] closed

Feb 15 23:36 : decoder_thread: probing plugin vorbis

Feb 15 23:36 : decoder_thread: probing plugin oggflac

Feb 15 23:36 : decoder: audio_format=48000:24:2, seekable=false

Feb 15 23:36 : alsa_output: opened _audioout type=COPY

Feb 15 23:36 : alsa_output: buffer: size=64..65536 time=1333..1365334

Feb 15 23:36 : alsa_output: period: size=32..32768 time=666..682667

Feb 15 23:36 : alsa_output: default period_time = buffer_time/4 = 200000/4 = 50000

Feb 15 23:36 : alsa_output: format=S24_LE (Signed 24 bit Little Endian)

Feb 15 23:36 : alsa_output: buffer_size=9600 period_size=2400

Feb 15 23:36 : output: opened "ALSA Default" (alsa) audio_format=48000:24:2

Feb 15 23:36 : client: [34] process command "status"

Feb 15 23:36 : client: [34] command returned 0

Feb 15 23:36 : client: [33] process command "status"

Feb 15 23:36 : client: [33] command returned 0

Feb 15 23:36 : client: [34] process command "currentsong"

Feb 15 23:36 : client: [34] command returned 0

Feb 15 23:36 : client: [33] process command "currentsong"

Feb 15 23:36 : client: [33] command returned 0

Feb 15 23:36 : client: [33] process command "close"

Feb 15 23:36 : client: [33] command returned 4

Feb 15 23:36 : client: [33] closed

Feb 15 23:36 : client: [34] process command "close"

Feb 15 23:36 : client: [34] command returned 4

Feb 15 23:36 : client: [34] closed

Feb 15 23:36 : client: [38] opened from 127.0.0.1:36850

Feb 15 23:36 : client: [38] process command "status"

Feb 15 23:36 : client: [38] command returned 0

Feb 15 23:36 : client: [38] process command "idle"

Feb 15 23:36 : client: [38] command returned 1

Feb 15 23:36 : client: [39] opened from 127.0.0.1:36864

Feb 15 23:36 : client: [39] process command "status"

Feb 15 23:36 : client: [39] command returned 0

Feb 15 23:36 : client: [39] process command "idle"

Feb 15 23:36 : client: [39] command returned 1

Feb 15 23:36 : client: [40] opened from 127.0.0.1:36876

Feb 15 23:36 : client: [40] process command "playlistinfo"

Feb 15 23:36 : client: [40] command returned 0

Feb 15 23:36 : client: [40] process command "close"

Feb 15 23:36 : client: [40] command returned 4

Feb 15 23:36 : client: [40] closed

Feb 15 23:36 : client: [41] opened from 127.0.0.1:36892

Feb 15 23:36 : client: [41] process command "playlistinfo"

Feb 15 23:36 : client: [41] command returned 0

Feb 15 23:36 : client: [41] process command "close"

Feb 15 23:36 : client: [41] command returned 4

Feb 15 23:36 : client: [41] closed

Feb 15 23:36 : client: [39] process command "status"

Feb 15 23:36 : client: [39] command returned 0

Feb 15 23:36 : client: [38] process command "status"

Feb 15 23:36 : client: [38] command returned 0

Feb 15 23:36 : client: [38] process command "currentsong"

Feb 15 23:36 : client: [38] command returned 0

Feb 15 23:36 : client: [39] process command "currentsong"

Feb 15 23:36 : client: [39] command returned 0

Feb 15 23:36 : client: [39] process command "close"

Feb 15 23:36 : client: [39] command returned 4

Feb 15 23:36 : client: [39] closed

Feb 15 23:36 : client: [38] process command "close"

Feb 15 23:36 : client: [38] command returned 4

Feb 15 23:36 : client: [38] closed

Feb 15 23:36 : client: [42] opened from 127.0.0.1:36908

Feb 15 23:36 : client: [42] process command "status"

Feb 15 23:36 : client: [42] command returned 0

Feb 15 23:36 : client: [42] process command "idle"

Feb 15 23:36 : client: [42] command returned 1

Feb 15 23:36 : client: [43] opened from 127.0.0.1:36920

Feb 15 23:36 : client: [43] process command "playlistinfo"

Feb 15 23:36 : client: [43] command returned 0

Feb 15 23:36 : client: [43] process command "close"

Feb 15 23:36 : client: [43] command returned 4

Feb 15 23:36 : client: [43] closed

Feb 15 23:36 : client: [44] opened from 127.0.0.1:36922

Feb 15 23:36 : client: [44] process command "status"

Feb 15 23:36 : client: [44] command returned 0

Feb 15 23:36 : client: [44] process command "idle"

Feb 15 23:36 : client: [44] command returned 1

Feb 15 23:36 : client: [45] opened from 127.0.0.1:36930

Feb 15 23:36 : client: [45] process command "playlistinfo"

Feb 15 23:36 : client: [45] command returned 0

Feb 15 23:36 : client: [45] process command "close"

Feb 15 23:36 : client: [45] command returned 4

Feb 15 23:36 : client: [45] closed

Feb 15 23:36 : alsa_output: Decoder is too slow; playing silence to avoid xrun

Feb 15 23:36 : client: [46] opened from 127.0.0.1:60172

Feb 15 23:36 : client: [46] process command "stop"

Feb 15 23:36 : playlist: stop

Feb 15 23:36 : player: played "https://stream.and-stuff.nl:8443/riverside"

Have you replicated the problem in your environment?
Thanks again and best regards,
Francesco
P.S.: please note that the defaul values was 500000 and 125000.

Login
Username:
Password:	Lost Password?
	Remember me