<div dir="ltr"><div dir="ltr"><br></div><br><div class="gmail_quote"><div dir="ltr" class="gmail_attr">On Tue, Jun 15, 2021 at 7:44 AM George Joseph <<a href="mailto:gjoseph@sangoma.com">gjoseph@sangoma.com</a>> wrote:<br></div><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex"><div dir="ltr"><div dir="ltr"><br></div><br><div class="gmail_quote"><div dir="ltr" class="gmail_attr">On Mon, Jun 14, 2021 at 1:16 PM Dan Cropp <<a href="mailto:dan@amtelco.com" target="_blank">dan@amtelco.com</a>> wrote:<br></div><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex">
<div lang="EN-US">
<div>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">I think you are onto something with the system time being slewed backwards.<u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">Logs showed this happened at the same time things went down<u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)"><u></u> <u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">systemd-timesyncd[684]: Synchronized to time server …..</span></p></div></div></blockquote><div><br></div><div>We have a winner!!</div><div> </div><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex"><div lang="EN-US"><div><p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)"><u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)"><u></u> <u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)"><u></u> <u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">I’m looking at the coredump from my own box (same executable, just different box).<u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">Here is the output from the coredump you asked for.<u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)"><u></u> <u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">If it needs to be on the customer box, let me know. Pretty sure I can have someone with permissions access the box and do the same work I did.</span></p></div></div></blockquote><div><br></div><div>As long as the binaries and distro are the same, examining a coredump on a different box is fine. We do it all the time.</div><div> </div><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex"><div lang="EN-US"><div><p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)"><u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)"><u></u> <u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">(gdb) frame 6<u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">#6 0x00005588eef3a392 in hook_event_cb (chan=<optimized out>, frame=<optimized out>, event=<optimized out>, data=0x7f017411f4e0) at abstract_jb.c:1127<u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">1127 abstract_jb.c: No such file or directory.<u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">(gdb) p now<u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">$1 = 18446744073709550143</span></p></div></div></blockquote><div><br></div><div>Yeah that's -1473. </div><div><br></div><div>Could you open an ASTERISK issue for this? Something like "Negative time differences causes an abort in fixedjitterbuffer.c".</div><div>We should just pass through any frame with a negative interval and remove that ASSERT statement.</div></div></div></blockquote><div><br></div><div>I opened <a href="https://issues.asterisk.org/jira/browse/ASTERISK-29480">ASTERISK-29480</a> for you.</div><div> <br></div><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex"><div dir="ltr"><div class="gmail_quote"><div><br></div><div> </div><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex"><div lang="EN-US"><div><p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)"><u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">(gdb) p now_tv<u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">$2 = <optimized out><u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">(gdb) p *framedata<u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">$3 = {jb_impl = 0x5588ef40b3e0 <avail_impl>, jb_conf = {flags = 0, max_size = 200, resync_threshold = 1000, impl = "fixed\000\000\000</span><span style="font-size:9pt;font-family:"Malgun Gothic",sans-serif;color:rgb(31,73,125)">䚗</span><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)">@",
target_extra = 40}, start_tv = {tv_sec = 1623549920, tv_usec = 123464}, last_format = 0x0,<u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)"> timer = 0x7f0174150fc0, timer_interval = 20, timer_fd = 379, first = 0, audio_stream_id = -1, audio_stream_sync = {timestamp = 0, ntp = {tv_sec = 0, tv_usec
= 0}}, video_stream_id = -1, video_stream_sync = {timestamp = 0, ntp = {<u></u><u></u></span></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Verdana,sans-serif;color:rgb(31,73,125)"> tv_sec = 0, tv_usec = 0}}, early_frames = {first = 0x0, last = 0x0}, early_frame_count = 0, last_audio_ntp_timestamp = {tv_sec = 0, tv_usec = 0}, audio_flowing
= 0, jb_obj = 0x7f01741b1990}<u></u><u></u></span></p>
<p class="MsoNormal"><u></u> <u></u></p>
<p class="MsoNormal">Dan<u></u><u></u></p>
<p class="MsoNormal"><u></u> <u></u></p>
<div style="border-right:none;border-bottom:none;border-left:none;border-top:1pt solid rgb(225,225,225);padding:3pt 0in 0in">
<p class="MsoNormal"><b>From:</b> asterisk-dev <<a href="mailto:asterisk-dev-bounces@lists.digium.com" target="_blank">asterisk-dev-bounces@lists.digium.com</a>>
<b>On Behalf Of </b>George Joseph<br>
<b>Sent:</b> Monday, June 14, 2021 1:58 PM<br>
<b>To:</b> Asterisk Developers Mailing List <<a href="mailto:asterisk-dev@lists.digium.com" target="_blank">asterisk-dev@lists.digium.com</a>><br>
<b>Subject:</b> Re: [asterisk-dev] Asterisk crash<u></u><u></u></p>
</div>
<p class="MsoNormal"><u></u> <u></u></p>
<div>
<div>
<p class="MsoNormal">That's pretty weird. The ASSERT in frame 4 makes sure that the time difference between the frame's timestamp and the current time is positive so a negative value will cause the assert. Actually, I think there's a bug there. Most asserts
in Asterisk are enabled only when it's built with --enable-dev-mode. This assert seems to trigger even without --enable-dev-mode.<u></u><u></u></p>
</div>
<div>
<p class="MsoNormal"><u></u> <u></u></p>
</div>
<div>
<p class="MsoNormal">Anyway, if you still have the actual coredump, it'd be interesting to do the following in gdb...<u></u><u></u></p>
</div>
<div>
<p class="MsoNormal"><u></u> <u></u></p>
</div>
<div>
<p class="MsoNormal">gdb> frame 6<u></u><u></u></p>
</div>
<div>
<p class="MsoNormal">gdb> p now<u></u><u></u></p>
</div>
<div>
<p class="MsoNormal">gdb> p now_tv<u></u><u></u></p>
</div>
<div>
<p class="MsoNormal">gdb> p *framedata<u></u><u></u></p>
</div>
<div>
<p class="MsoNormal"><u></u> <u></u></p>
</div>
<div>
<p class="MsoNormal">I'm wondering if the system time is being slewed backwards by ntpd, chronyd, systemd-timesyncd, etc.<u></u><u></u></p>
</div>
<div>
<p class="MsoNormal"><u></u> <u></u></p>
</div>
<p class="MsoNormal"><u></u> <u></u></p>
<div>
<div>
<p class="MsoNormal">On Mon, Jun 14, 2021 at 10:49 AM Dan Cropp <<a href="mailto:dan@amtelco.com" target="_blank">dan@amtelco.com</a>> wrote:<u></u><u></u></p>
</div>
<blockquote style="border-top:none;border-right:none;border-bottom:none;border-left:1pt solid rgb(204,204,204);padding:0in 0in 0in 6pt;margin-left:4.8pt;margin-right:0in">
<div>
<div>
<p class="MsoNormal">We have a customer with asterisk 16.17.0 installed. Every once in a while, we have been seeing a crash. We have upgraded the version a couple times, but this random crashing issue
has been going on for some time.<u></u><u></u></p>
<p class="MsoNormal"> <u></u><u></u></p>
<p class="MsoNormal">Over the weekend, it happened again. This time, I have a .crash file from it.<u></u><u></u></p>
<p class="MsoNormal">Put it through apport-unpack and think I have a good CoreDump from it.<u></u><u></u></p>
<p class="MsoNormal">Running asterisk 16.17.0 here is what the gdb backtrace is showing.<u></u><u></u></p>
<p class="MsoNormal"> <u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">Program terminated with signal SIGABRT, Aborted.</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#0 __GI_raise (sig=sig@entry=6) at ../sysdeps/unix/sysv/linux/raise.c:51</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">51 ../sysdeps/unix/sysv/linux/raise.c: No such file or directory.</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">[Current thread is 1 (Thread 0x7f014097d700 (LWP 20262))]</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">(gdb) bt</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#0 __GI_raise (sig=sig@entry=6) at ../sysdeps/unix/sysv/linux/raise.c:51</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#1 0x00007f027877a921 in __GI_abort () at abort.c:79</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#2 0x00007f027876a48a in __assert_fail_base (fmt=0x7f02788f1750 "%s%s%s:%u: %s%sAssertion `%s' failed.\n%n",
assertion=assertion@entry=0x5588ef1864a9 "now >= 0",</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black"> file=file@entry=0x5588ef18645a "fixedjitterbuf.c", line=line@entry=293, function=function@entry=0x5588ef1864f8
<__PRETTY_FUNCTION__.9166> "fixed_jb_get")</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black"> at assert.c:92</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#3 0x00007f027876a502 in __GI___assert_fail (assertion=assertion@entry=0x5588ef1864a9 "now >= 0", file=file@entry=0x5588ef18645a
"fixedjitterbuf.c",</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black"> line=line@entry=293, function=function@entry=0x5588ef1864f8 <__PRETTY_FUNCTION__.9166> "fixed_jb_get")
at assert.c:101</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#4 0x00005588eeffe999 in fixed_jb_get (jb=<optimized out>, frame=frame@entry=0x7f01409785c0, now=<optimized
out>, interpl=<optimized out>) at fixedjitterbuf.c:293</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#5 0x00005588eef39ee2 in jb_get_fixed (jb=<optimized out>, fout=0x7f0140978628, now=<optimized out>, interpl=<optimized
out>) at abstract_jb.c:675</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#6 0x00005588eef3a392 in hook_event_cb (chan=<optimized out>, frame=<optimized out>, event=<optimized out>,
data=0x7f017411f4e0) at abstract_jb.c:1127</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#7 0x00005588ef008935 in framehook_list_push_event (framehooks=0x7f01741bca40, frame=frame@entry=0x5588ef416aa0
<ast_null_frame>,</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black"> event=event@entry=AST_FRAMEHOOK_EVENT_READ) at framehook.c:116</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#8 0x00005588ef009177 in ast_framehook_list_read_event (framehooks=<optimized out>, frame=frame@entry=0x5588ef416aa0
<ast_null_frame>) at framehook.c:320</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#9 0x00005588eefbb1b1 in __ast_read (chan=chan@entry=0x7f016c1abf30, dropaudio=dropaudio@entry=0, dropnondefault=dropnondefault@entry=1)
at channel.c:3779</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#10 0x00005588eefbd40c in ast_read (chan=chan@entry=0x7f016c1abf30) at channel.c:4285</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#11 0x00007f01cbf77b9c in async_agi_read_frame (chan=0x7f016c1abf30) at res_agi.c:1763</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#12 launch_asyncagi (efd=0x0, argv=0x7f0140978ae8, argc=<optimized out>, chan=0x7f016c1abf30) at res_agi.c:1960</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#13 launch_script (opid=<synthetic pointer>, efd=0x0, fds=0x7f0140978a30, argv=0x7f0140978ae8, argc=<optimized
out>, script=<optimized out>, chan=0x7f016c1abf30)</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black"> at res_agi.c:2213</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#14 agi_exec_full (chan=0x7f016c1abf30, data=<optimized out>, enhanced=<optimized out>, dead=0) at res_agi.c:4521</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#15 0x00005588ef04bf92 in pbx_exec (c=c@entry=0x7f016c1abf30, app=app@entry=0x5588efbed4b0, data=data@entry=0x7f014097ac00
"agi:async") at pbx_app.c:492</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#16 0x00005588ef03d062 in pbx_extension_helper (c=c@entry=0x7f016c1abf30, context=0x7f016c1ac8f0 "IS", exten=exten@entry=0x7f016c1ac940
"1234",</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black"> priority=priority@entry=15, label=label@entry=0x0, callerid=callerid@entry=0x0, action=E_SPAWN, found=0x7f014097ccac,
combined_find_spawn=1, con=0x0) at pbx.c:2947</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#17 0x00005588ef041143 in ast_spawn_extension (combined_find_spawn=1, found=0x7f014097ccac, callerid=0x0,
priority=15, exten=0x7f016c1ac940 "1234",</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black"> context=<optimized out>, c=0x7f016c1abf30) at pbx.c:4206</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#18 __ast_pbx_run (c=c@entry=0x7f016c1abf30, args=args@entry=0x0) at pbx.c:4380</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#19 0x00005588ef04282b in pbx_thread (data=data@entry=0x7f016c1abf30) at pbx.c:4704</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#20 0x00005588ef0cf41f in dummy_start (data=<optimized out>) at utils.c:1299</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#21 0x00007f02793216db in start_thread (arg=0x7f014097d700) at pthread_create.c:463</span><u></u><u></u></p>
<p class="MsoNormal"><span style="font-size:9pt;font-family:Arial,sans-serif;color:black">#22 0x00007f027885b71f in clone () at ../sysdeps/unix/sysv/linux/x86_64/clone.S:95</span><u></u><u></u></p>
<p class="MsoNormal"> <u></u><u></u></p>
<p class="MsoNormal"> <u></u><u></u></p>
<p class="MsoNormal">Any suggestions of what I could try?<u></u><u></u></p>
<p class="MsoNormal"> <u></u><u></u></p>
<p class="MsoNormal">Dan<u></u><u></u></p>
</div>
</div>
<p class="MsoNormal">-- <br>
_____________________________________________________________________<br>
-- Bandwidth and Colocation Provided by <a href="http://www.api-digital.com" target="_blank">
http://www.api-digital.com</a> --<br>
<br>
asterisk-dev mailing list<br>
To UNSUBSCRIBE or update options visit:<br>
<a href="http://lists.digium.com/mailman/listinfo/asterisk-dev" target="_blank">http://lists.digium.com/mailman/listinfo/asterisk-dev</a><u></u><u></u></p>
</blockquote>
</div>
</div>
</div>
</div>
-- <br>
_____________________________________________________________________<br>
-- Bandwidth and Colocation Provided by <a href="http://www.api-digital.com" rel="noreferrer" target="_blank">http://www.api-digital.com</a> --<br>
<br>
asterisk-dev mailing list<br>
To UNSUBSCRIBE or update options visit:<br>
<a href="http://lists.digium.com/mailman/listinfo/asterisk-dev" rel="noreferrer" target="_blank">http://lists.digium.com/mailman/listinfo/asterisk-dev</a></blockquote></div></div>
</blockquote></div></div>