* Re: [LAD] Mackie Onyx 1640i: Long run playback results in xrun and hang. [not found] <FC940720-82E9-4091-8ED0-36AA3CC4D682@paranoici.org> @ 2021-09-13 11:36 ` AreYouLoco? 2021-09-21 17:34 ` AreYouLoco? 0 siblings, 1 reply; 2+ messages in thread From: AreYouLoco? @ 2021-09-13 11:36 UTC (permalink / raw) To: linux-audio-dev, alsa-devel I am going to recompile the kernel with options mentioned here: https://www.alsa-project.org/main/index.php/XRUN_Debug And try to debug why the xrun appears. I also checked with buffer size 1024 and exaclty one xrun and then hang repeats. On 9/13/21 12:23 PM, AreYouLoco? wrote: > Hi, > > I am using custom build real-time kernel 5.12.2-rt3-fw. JACK with ALSA > backend on Mackie Onyx 1640i. > Lenovo Thinkpad T420 with FireWire. Debian Bullseye (11.0 - stable) > JACKD version 1.9.17. > I am using 512 samples 3 periods @48kHz. > > The problem is that long run playback only around 1h (but the time > differs), result in > XRUN detected by JACK logs and the whole audio stops. So I have to > restart JACK in order to make it work. > DMESG is silent about that issue. But sometimes I get: > > snd_oxfw fw1.0: Detect discontinuity of CIP: E8 00 > And different hex values there. > > Here is interesting part from the log: > > Sun Sep 12 22:10:12 2021: Jack: JackRequest::Notification > Sun Sep 12 22:10:12 2021: Jack: **** alsa_pcm: xrun of at least 0.027 msecs > Sun Sep 12 22:10:12 2021: Jack: Repreparing capture > Sun Sep 12 22:10:12 2021: Jack: Repreparing playback > Sun Sep 12 22:10:12 2021: Jack: ALSA XRun wait_status = 0 > Sun Sep 12 22:10:12 2021: Jack: JackEngine::ClientNotify: no callback > for notification = 3 > Sun Sep 12 22:10:12 2021: Jack: JackEngine::ClientNotify: no callback > for notification = 3 > Sun Sep 12 22:10:12 2021: Jack: JackClient::ClientNotify ref = 2 name = > dbusapi notify = 3 > Sun Sep 12 22:10:12 2021: Jack: JackClient::kXRunCallback > Sun Sep 12 22:10:12 2021: Jack: JackEngine::ClientNotify: no callback > for notification = 3 > Sun Sep 12 22:10:12 2021: Jack: JackEngine::ClientNotify: no callback > for notification = 3 > Sun Sep 12 22:10:12 2021: Jack: JackEngine::ClientNotify: no callback > for notification = 3 > Sun Sep 12 22:10:12 2021: Jack: JackEngine::ClientNotify: no callback > for notification = 3 > Sun Sep 12 22:10:28 2021: ERROR: ALSA: poll time out, polled for > 15998655 usecs, Retrying with a recovery, retry cnt = 1 > Sun Sep 12 22:10:44 2021: ERROR: ALSA: poll time out, polled for > 15998654 usecs, Retrying with a recovery, retry cnt = 2 > Sun Sep 12 22:11:00 2021: ERROR: ALSA: poll time out, polled for > 15998659 usecs, Retrying with a recovery, retry cnt = 3 > Sun Sep 12 22:11:16 2021: ERROR: ALSA: poll time out, polled for > 15998649 usecs, Retrying with a recovery, retry cnt = 4 > > Anyone have idea what might be the cause of this XRUN? Or how to debug that? > > Its reproducible on my setup. Another log catched the same issue: > > Sun Sep 12 16:50:44 2021: Jack: **** alsa_pcm: xrun of at least 0.030 msecs > Sun Sep 12 16:50:44 2021: Jack: Repreparing capture > Sun Sep 12 16:50:44 2021: Jack: Repreparing playback > Sun Sep 12 16:50:44 2021: Jack: ALSA XRun wait_status = 0 > Sun Sep 12 16:50:44 2021: Jack: JackRequest::Notification > Sun Sep 12 16:50:44 2021: Jack: JackEngine::ClientNotify: no callback > for notification = 3 > Sun Sep 12 16:50:44 2021: Jack: JackEngine::ClientNotify: no callback > for notification = 3 > Sun Sep 12 16:50:44 2021: Jack: JackClient::ClientNotify ref = 2 name = > dbusapi notify = 3 > Sun Sep 12 16:50:44 2021: Jack: JackClient::kXRunCallback > Sun Sep 12 16:50:44 2021: Jack: JackEngine::ClientNotify: no callback > for notification = 3 > Sun Sep 12 16:50:44 2021: Jack: JackEngine::ClientNotify: no callback > for notification = 3 > Sun Sep 12 16:50:44 2021: Jack: JackEngine::ClientNotify: no callback > for notification = 3 > Sun Sep 12 16:50:44 2021: Jack: JackEngine::ClientNotify: no callback > for notification = 3 > Sun Sep 12 16:51:00 2021: ERROR: ALSA: poll time out, polled for > 15998366 usecs, Retrying with a recovery, retry cnt = 1 > Sun Sep 12 16:51:16 2021: ERROR: ALSA: poll time out, polled for > 15998353 usecs, Retrying with a recovery, retry cnt = 2 > Sun Sep 12 16:51:32 2021: ERROR: ALSA: poll time out, polled for > 15998352 usecs, Retrying with a recovery, retry cnt = 3 > Sun Sep 12 16:51:48 2021: ERROR: ALSA: poll time out, polled for > 15998367 usecs, Retrying with a recovery, retry cnt = 4 > Sun Sep 12 16:52:04 2021: ERROR: ALSA: poll time out, polled for > 15998353 usecs, Retrying with a recovery, retry cnt = 5 > Sun Sep 12 16:52:20 2021: ERROR: ALSA: poll time out, polled for > 15998371 usecs, Reached max retry cnt = 5, Exiting > Sun Sep 12 16:52:20 2021: ERROR: JackAudioDriver::ProcessAsync: read > error, stopping... > Sun Sep 12 16:52:20 2021: Jack: JackPosixThread::ThreadHandler : exit > > I am willing to provide additional info. > > Thank you in advance, > > AreYouLoco? > _______________________________________________ > Linux-audio-dev mailing list > Linux-audio-dev@lists.linuxaudio.org > https://lists.linuxaudio.org/listinfo/linux-audio-dev ^ permalink raw reply [flat|nested] 2+ messages in thread
* Re: [LAD] Mackie Onyx 1640i: Long run playback results in xrun and hang. 2021-09-13 11:36 ` [LAD] Mackie Onyx 1640i: Long run playback results in xrun and hang AreYouLoco? @ 2021-09-21 17:34 ` AreYouLoco? 0 siblings, 0 replies; 2+ messages in thread From: AreYouLoco? @ 2021-09-21 17:34 UTC (permalink / raw) To: linux-audio-dev, alsa-devel So the problem was pulseaudio hanging and not respawning because it cannot handle realtime priorities. On September 13, 2021 11:36:59 AM UTC, AreYouLoco? <areyouloco@paranoici.org> wrote: >I am going to recompile the kernel with options mentioned here: > >https://www.alsa-project.org/main/index.php/XRUN_Debug > >And try to debug why the xrun appears. > >I also checked with buffer size 1024 and exaclty one xrun and then hang repeats. > >On 9/13/21 12:23 PM, AreYouLoco? wrote: >> Hi, >> >> I am using custom build real-time kernel 5.12.2-rt3-fw. JACK with ALSA >> backend on Mackie Onyx 1640i. >> Lenovo Thinkpad T420 with FireWire. Debian Bullseye (11.0 - stable) >> JACKD version 1.9.17. >> I am using 512 samples 3 periods @48kHz. >> >> The problem is that long run playback only around 1h (but the time >> differs), result in >> XRUN detected by JACK logs and the whole audio stops. So I have to >> restart JACK in order to make it work. >> DMESG is silent about that issue. But sometimes I get: >> >> snd_oxfw fw1.0: Detect discontinuity of CIP: E8 00 >> And different hex values there. >> >> Here is interesting part from the log: >> >> Sun Sep 12 22:10:12 2021: Jack: JackRequest::Notification >> Sun Sep 12 22:10:12 2021: Jack: **** alsa_pcm: xrun of at least 0.027 msecs >> Sun Sep 12 22:10:12 2021: Jack: Repreparing capture >> Sun Sep 12 22:10:12 2021: Jack: Repreparing playback >> Sun Sep 12 22:10:12 2021: Jack: ALSA XRun wait_status = 0 >> Sun Sep 12 22:10:12 2021: Jack: JackEngine::ClientNotify: no callback >> for notification = 3 >> Sun Sep 12 22:10:12 2021: Jack: JackEngine::ClientNotify: no callback >> for notification = 3 >> Sun Sep 12 22:10:12 2021: Jack: JackClient::ClientNotify ref = 2 name = >> dbusapi notify = 3 >> Sun Sep 12 22:10:12 2021: Jack: JackClient::kXRunCallback >> Sun Sep 12 22:10:12 2021: Jack: JackEngine::ClientNotify: no callback >> for notification = 3 >> Sun Sep 12 22:10:12 2021: Jack: JackEngine::ClientNotify: no callback >> for notification = 3 >> Sun Sep 12 22:10:12 2021: Jack: JackEngine::ClientNotify: no callback >> for notification = 3 >> Sun Sep 12 22:10:12 2021: Jack: JackEngine::ClientNotify: no callback >> for notification = 3 >> Sun Sep 12 22:10:28 2021: ERROR: ALSA: poll time out, polled for >> 15998655 usecs, Retrying with a recovery, retry cnt = 1 >> Sun Sep 12 22:10:44 2021: ERROR: ALSA: poll time out, polled for >> 15998654 usecs, Retrying with a recovery, retry cnt = 2 >> Sun Sep 12 22:11:00 2021: ERROR: ALSA: poll time out, polled for >> 15998659 usecs, Retrying with a recovery, retry cnt = 3 >> Sun Sep 12 22:11:16 2021: ERROR: ALSA: poll time out, polled for >> 15998649 usecs, Retrying with a recovery, retry cnt = 4 >> >> Anyone have idea what might be the cause of this XRUN? Or how to debug that? >> >> Its reproducible on my setup. Another log catched the same issue: >> >> Sun Sep 12 16:50:44 2021: Jack: **** alsa_pcm: xrun of at least 0.030 msecs >> Sun Sep 12 16:50:44 2021: Jack: Repreparing capture >> Sun Sep 12 16:50:44 2021: Jack: Repreparing playback >> Sun Sep 12 16:50:44 2021: Jack: ALSA XRun wait_status = 0 >> Sun Sep 12 16:50:44 2021: Jack: JackRequest::Notification >> Sun Sep 12 16:50:44 2021: Jack: JackEngine::ClientNotify: no callback >> for notification = 3 >> Sun Sep 12 16:50:44 2021: Jack: JackEngine::ClientNotify: no callback >> for notification = 3 >> Sun Sep 12 16:50:44 2021: Jack: JackClient::ClientNotify ref = 2 name = >> dbusapi notify = 3 >> Sun Sep 12 16:50:44 2021: Jack: JackClient::kXRunCallback >> Sun Sep 12 16:50:44 2021: Jack: JackEngine::ClientNotify: no callback >> for notification = 3 >> Sun Sep 12 16:50:44 2021: Jack: JackEngine::ClientNotify: no callback >> for notification = 3 >> Sun Sep 12 16:50:44 2021: Jack: JackEngine::ClientNotify: no callback >> for notification = 3 >> Sun Sep 12 16:50:44 2021: Jack: JackEngine::ClientNotify: no callback >> for notification = 3 >> Sun Sep 12 16:51:00 2021: ERROR: ALSA: poll time out, polled for >> 15998366 usecs, Retrying with a recovery, retry cnt = 1 >> Sun Sep 12 16:51:16 2021: ERROR: ALSA: poll time out, polled for >> 15998353 usecs, Retrying with a recovery, retry cnt = 2 >> Sun Sep 12 16:51:32 2021: ERROR: ALSA: poll time out, polled for >> 15998352 usecs, Retrying with a recovery, retry cnt = 3 >> Sun Sep 12 16:51:48 2021: ERROR: ALSA: poll time out, polled for >> 15998367 usecs, Retrying with a recovery, retry cnt = 4 >> Sun Sep 12 16:52:04 2021: ERROR: ALSA: poll time out, polled for >> 15998353 usecs, Retrying with a recovery, retry cnt = 5 >> Sun Sep 12 16:52:20 2021: ERROR: ALSA: poll time out, polled for >> 15998371 usecs, Reached max retry cnt = 5, Exiting >> Sun Sep 12 16:52:20 2021: ERROR: JackAudioDriver::ProcessAsync: read >> error, stopping... >> Sun Sep 12 16:52:20 2021: Jack: JackPosixThread::ThreadHandler : exit >> >> I am willing to provide additional info. >> >> Thank you in advance, >> >> AreYouLoco? >> _______________________________________________ >> Linux-audio-dev mailing list >> Linux-audio-dev@lists.linuxaudio.org >> https://lists.linuxaudio.org/listinfo/linux-audio-dev > ^ permalink raw reply [flat|nested] 2+ messages in thread
end of thread, other threads:[~2021-09-21 17:35 UTC | newest] Thread overview: 2+ messages (download: mbox.gz / follow: Atom feed) -- links below jump to the message on this page -- [not found] <FC940720-82E9-4091-8ED0-36AA3CC4D682@paranoici.org> 2021-09-13 11:36 ` [LAD] Mackie Onyx 1640i: Long run playback results in xrun and hang AreYouLoco? 2021-09-21 17:34 ` AreYouLoco?
This is a public inbox, see mirroring instructions for how to clone and mirror all data and code used for this inbox; as well as URLs for NNTP newsgroup(s).