From fa2e07a0bd4d02280c397099b612ce4d56673c10 Mon Sep 17 00:00:00 2001 From: Lennart Poettering Date: Fri, 20 Feb 2009 03:19:33 +0100 Subject: add test tool for debugging broken timing in sound drivers --- src/Makefile.am | 14 +++- src/tests/alsa-time-test.c | 200 +++++++++++++++++++++++++++++++++++++++++++++ 2 files changed, 212 insertions(+), 2 deletions(-) create mode 100644 src/tests/alsa-time-test.c diff --git a/src/Makefile.am b/src/Makefile.am index f385c0ab..ceafdf79 100644 --- a/src/Makefile.am +++ b/src/Makefile.am @@ -313,6 +313,11 @@ TESTS_BINARIES += \ gtk-test endif +if HAVE_ALSA +TESTS_BINARIES += \ + alsa-time-test +endif + if BUILD_TESTS_DEFAULT noinst_PROGRAMS = $(TESTS_BINARIES) else @@ -514,6 +519,11 @@ gtk_test_LDADD = $(AM_LDADD) libpulse.la libpulse-mainloop-glib.la gtk_test_CFLAGS = $(AM_CFLAGS) $(GTK20_CFLAGS) gtk_test_LDFLAGS = $(AM_LDFLAGS) $(BINLDFLAGS) $(GTK20_LIBS) +alsa_time_test_SOURCES = tests/alsa-time-test.c +alsa_time_test_LDADD = $(AM_LDADD) +alsa_time_test_CFLAGS = $(AM_CFLAGS) $(ASOUNDLIB_CFLAGS) +alsa_time_test_LDFLAGS = $(AM_LDFLAGS) $(BINLDFLAGS) $(ASOUNDLIB_LIBS) + ################################### # Common library # ################################### @@ -960,6 +970,8 @@ modlibexec_LTLIBRARIES += \ module-oss.la endif +pulselibexec_PROGRAMS = + if HAVE_ALSA modlibexec_LTLIBRARIES += \ libalsa-util.la \ @@ -995,8 +1007,6 @@ modlibexec_LTLIBRARIES += \ module-jack-source.la endif -pulselibexec_PROGRAMS = - if HAVE_GCONF modlibexec_LTLIBRARIES += \ module-gconf.la diff --git a/src/tests/alsa-time-test.c b/src/tests/alsa-time-test.c new file mode 100644 index 00000000..3858bf7b --- /dev/null +++ b/src/tests/alsa-time-test.c @@ -0,0 +1,200 @@ +#include +#include +#include + +#include + +static uint64_t timespec_us(const struct timespec *ts) { + return + ts->tv_sec * 1000000LLU + + ts->tv_nsec / 1000LLU; +} + +int main(int argc, char *argv[]) { + const char *dev; + int r; + snd_pcm_hw_params_t *hwparams; + snd_pcm_sw_params_t *swparams; + snd_pcm_status_t *status; + snd_pcm_t *pcm; + unsigned rate = 44100; + unsigned periods = 0; + snd_pcm_uframes_t boundary, buffer_size = 44100/10; /* 100s */ + int dir = 1; + struct timespec start, last_timestamp = { 0, 0 }; + uint64_t start_us; + snd_pcm_sframes_t last_avail, last_delay; + struct pollfd *pollfds; + int n_pollfd; + int64_t sample_count = 0; + + snd_pcm_hw_params_alloca(&hwparams); + snd_pcm_sw_params_alloca(&swparams); + snd_pcm_status_alloca(&status); + + r = clock_gettime(CLOCK_MONOTONIC, &start); + assert(r == 0); + + start_us = timespec_us(&start); + + dev = argc > 1 ? argv[1] : "front:AudioPCI"; + + r = snd_pcm_open(&pcm, dev, SND_PCM_STREAM_PLAYBACK, 0); + assert(r == 0); + + r = snd_pcm_hw_params_any(pcm, hwparams); + assert(r == 0); + + r = snd_pcm_hw_params_set_rate_resample(pcm, hwparams, 0); + assert(r == 0); + + r = snd_pcm_hw_params_set_access(pcm, hwparams, SND_PCM_ACCESS_RW_INTERLEAVED); + assert(r == 0); + + r = snd_pcm_hw_params_set_format(pcm, hwparams, SND_PCM_FORMAT_S16_LE); + assert(r == 0); + + r = snd_pcm_hw_params_set_rate_near(pcm, hwparams, &rate, NULL); + assert(r == 0); + + r = snd_pcm_hw_params_set_channels(pcm, hwparams, 2); + assert(r == 0); + + r = snd_pcm_hw_params_set_periods_integer(pcm, hwparams); + assert(r == 0); + + r = snd_pcm_hw_params_set_periods_near(pcm, hwparams, &periods, &dir); + assert(r == 0); + + r = snd_pcm_hw_params_set_buffer_size_near(pcm, hwparams, &buffer_size); + assert(r == 0); + + r = snd_pcm_hw_params(pcm, hwparams); + assert(r == 0); + + r = snd_pcm_hw_params_current(pcm, hwparams); + assert(r == 0); + + r = snd_pcm_sw_params_set_avail_min(pcm, swparams, 1); + assert(r == 0); + + r = snd_pcm_sw_params_set_period_event(pcm, swparams, 1); + assert(r == 0); + + r = snd_pcm_hw_params_get_buffer_size(hwparams, &buffer_size); + assert(r == 0); + r = snd_pcm_sw_params_set_start_threshold(pcm, swparams, buffer_size); + assert(r == 0); + + r = snd_pcm_sw_params_get_boundary(swparams, &boundary); + assert(r == 0); + r = snd_pcm_sw_params_set_stop_threshold(pcm, swparams, boundary); + assert(r == 0); + + r = snd_pcm_sw_params_set_tstamp_mode(pcm, swparams, SND_PCM_TSTAMP_ENABLE); + assert(r == 0); + + r = snd_pcm_sw_params(pcm, swparams); + assert(r == 0); + + r = snd_pcm_prepare(pcm); + assert(r == 0); + + r = snd_pcm_sw_params_current(pcm, swparams); + assert(r == 0); + +/* assert(snd_pcm_hw_params_is_monotonic(hwparams) > 0); */ + + n_pollfd = snd_pcm_poll_descriptors_count(pcm); + assert(n_pollfd > 0); + + pollfds = malloc(sizeof(struct pollfd) * n_pollfd); + assert(pollfds); + + r = snd_pcm_poll_descriptors(pcm, pollfds, n_pollfd); + assert(r == n_pollfd); + + for (;;) { + snd_pcm_sframes_t avail, delay; +/* snd_pcm_uframes_t avail2; */ + struct timespec now, timestamp; + unsigned short revents; + int written = 0; + uint64_t now_us, timestamp_us; + snd_pcm_state_t state; + + r = poll(pollfds, n_pollfd, 0); + assert(r >= 0); + + r = snd_pcm_poll_descriptors_revents(pcm, pollfds, n_pollfd, &revents); + assert(r == 0); + + assert((revents & ~POLLOUT) == 0); + +/* state = snd_pcm_get_state(pcm); */ + + avail = snd_pcm_avail(pcm); + assert(avail >= 0); + + r = snd_pcm_status(pcm, status); + assert(r == 0); + + printf("%lu %lu\n", (unsigned long) avail, (unsigned long) snd_pcm_status_get_avail(status)); + + assert(avail == (snd_pcm_sframes_t) snd_pcm_status_get_avail(status)); + snd_pcm_status_get_htstamp(status, ×tamp); + delay = snd_pcm_status_get_delay(status); + state = snd_pcm_status_get_state(status); + +/* r = snd_pcm_avail_delay(pcm, &avail, &delay); */ +/* assert(r == 0); */ + +/* r = snd_pcm_htimestamp(pcm, &avail2, ×tamp); */ +/* assert(r == 0); */ + +/* assert(avail == (snd_pcm_sframes_t) avail2); */ + + r = clock_gettime(CLOCK_MONOTONIC, &now); + assert(r == 0); + + assert(!revents || avail > 0); + + if (avail) { + snd_pcm_sframes_t sframes; + static const uint16_t samples[2] = { 0, 0 }; + + sframes = snd_pcm_writei(pcm, samples, 1); + assert(sframes == 1); + + written = 1; + sample_count++; + } + + if (!written && + memcmp(×tamp, &last_timestamp, sizeof(timestamp)) == 0 && + avail == last_avail && + delay == last_delay) { + /* This is boring */ + continue; + } + + now_us = timespec_us(&now); + timestamp_us = timespec_us(×tamp); + + printf("%llu\t%llu\t%llu\t%li\t%li\t%i\t%i\t%i\n", + (unsigned long long) (now_us - start_us), + (unsigned long long) (timestamp_us ? timestamp_us - start_us : 0), + (unsigned long long) ((sample_count - 1 - delay) * 1000000LU / 44100), + (signed long) avail, + (signed long) delay, + revents, + written, + state); + + last_avail = avail; + last_delay = delay; + last_timestamp = timestamp; + } + + return 0; +} -- cgit