* 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).