[OpenSIPS-Users] sangoma issue ?

[Andy Dierlam]

forgot to mention this from:

opensips -V
version: opensips 3.0.4 (x86_64/linux)
flags: STATS: On, DISABLE_NAGLE, USE_MCAST, SHM_MMAP, PKG_MALLOC, Q_MALLOC,
F_MALLOC, HP_MALLOC, DBG_MALLOC, FAST_LOCK-ADAPTIVE_WAIT
ADAPTIVE_WAIT_LOOPS=1024, MAX_RECV_BUFFER_SIZE 262144, MAX_LISTEN 16,
MAX_URI_SIZE 1024, BUF_SIZE 65535
poll method support: poll, epoll, sigio_rt, select.
git revision: d19b20e
main.c compiled on 14:39:30 Dec 21 2020 with gcc 4.8.5

FYI get the same results from 2.4, 3.0, and 3.1





On Tue, Jan 12, 2021 at 3:14 PM Andy Dierlam <adierlam at ptgi-ics.com> wrote:

> Hello All,
>
> Wondering if anyone can offer some guidance on an issue seemingly with a
> newly setup Sangoma D-500 Transcoding card.
>
> Issue:
> When using transcoding, soon after 1 transcoded call completes, utimer
> task messages until opensips is restarted
> seems like it happens when fetch_dlg_value: looking for <SngTc>
>
> Jan 12 15:05:26 [21578] DBG:tm:timer_routine: timer
> routine:2,tl=0x7f9ce5fd3cc0 next=(nil), timeout=16
>
> Jan 12 15:05:26 [21578] DBG:tm:wait_handler: removing 0x7f9ce5fd3c40 from
> table
>
> Jan 12 15:05:26 [21578] DBG:tm:delete_cell: delete transaction
> 0x7f9ce5fd3c40
>
> Jan 12 15:05:26 [21578] DBG:tm:run_trans_callbacks: trans=0x7f9ce5fd3c40,
> callback type 4096, id 3 entered
>
> Jan 12 15:05:26 [21578] DBG:dialog:destroy_dlg: destroying dialog
> 0x7f9ce5fcdc50
>
> Jan 12 15:05:26 [21578] DBG:dialog:destroy_dlg: dlg expired or not in list
> - dlg 0x7f9ce5fcdc50 [57:1450509359] with clid
> '3b72b48a67a1eec840e2e1db12f8b37f at x.x.x.x' and tags 'as6d2cf831'
> 'Yjg9IHv3tknz-KgDTUF.K-lleno6X-hI'
>
> Jan 12 15:05:26 [21578] DBG:dialog:run_dlg_callbacks:
> dialog=0x7f9ce5fcdc50, type=2048
>
> Jan 12 15:05:26 [21578] DBG:dialog:fetch_dlg_value: looking for <SngTc>
>
> Jan 12 15:05:26 [21561] WARNING:core:utimer_ticker: utimer task
> <tm-utimer> already scheduled 100 ms ago (now 16950 ms), delaying execution
>
> Jan 12 15:05:26 [21561] WARNING:core:utimer_ticker: utimer task
> <tm-utimer> already scheduled 200 ms ago (now 17050 ms), delaying execution
>
> Jan 12 15:05:26 [21561] WARNING:core:utimer_ticker: utimer task
> <tm-utimer> already scheduled 300 ms ago (now 17150 ms), delaying execution
>
> Jan 12 15:05:26 [21561] WARNING:core:utimer_ticker: utimer task
> <tm-utimer> already scheduled 400 ms ago (now 17250 ms), delaying execution
>
> Jan 12 15:05:26 [21561] WARNING:core:utimer_ticker: utimer task
> <tm-utimer> already scheduled 490 ms ago (now 17340 ms), delaying execution
>
> Jan 12 15:05:26 [21561] WARNING:core:utimer_ticker: utimer task
> <tm-utimer> already scheduled 590 ms ago (now 17440 ms), delaying execution
>
> Jan 12 15:05:27 [21561] WARNING:core:utimer_ticker: utimer task
> <tm-utimer> already scheduled 690 ms ago (now 17540 ms), delaying execution
>
> Jan 12 15:05:27 [21561] WARNING:core:utimer_ticker: utimer task
> <tm-utimer> already scheduled 790 ms ago (now 17640 ms), delaying execution
>
> Jan 12 15:05:27 [21561] WARNING:core:utimer_ticker: utimer task
> <tm-utimer> already scheduled 890 ms ago (now 17740 ms), delaying execution
>
> Jan 12 15:05:27 [21561] WARNING:core:timer_ticker: timer task <tm-timer>
> already scheduled 990 ms ago (now 17740 ms), delayin
>
>
>
> opensips-cli trap output ( not sure what am looking at here, in case helps
> )
>
> #1  0x00007f9cde9aee5f in sangoma_worker_loop (proc_no=<optimized out>)
> at sngtc_proc.c:46
>
>         req = {type = REQ_FREE_SESSION, response_fd = 78, sng_req =
> {usr_priv = 0x7f9ce8c8f86b <asctime_r+139>, tag = 15, rtcp_enable = 5
> '\005', a = {codec_
>
> id = 32668, ms = 20, host_ip = 0, host_netmask = 2021, host_udp_port = 0},
> b = {codec_id = 9217376, ms = 0, host_ip = 3905485451, host_netmask =
> 32668, host_
>
> udp_port = 20}}, sng_reply = 0x7f9ce5fd2c78}
>
>         rc = 0
>
>         __FUNCTION__ = "sangoma_worker_loop"
>
> #2  0x00000000005045c8 in start_module_procs () at sr_module.c:858
>
>         m = 0x7f9ce7beafa8
>
>         n = 0
>
>         l = 0
>
>         x = <optimized out>
>
>         __FUNCTION__ = "start_module_procs"
>
> #3  0x000000000041e3df in main_loop () at main.c:779
>
>         startup_done = 0x0
>
>         chd_rank = 0
>
>         last_check = 0
>
>         rc = <optimized out>
>
> #4  main (argc=<optimized out>, argv=<optimized out>) at main.c:1479
>
>         c = <optimized out>
>
>         r = 0
>
>         tmp = 0x1 <Address 0x1 out of bounds>
>
>         tmp_len = <optimized out>
>
>         port = <optimized out>
>
>         proto = <optimized out>
>
>         protos_no = <optimized out>
>
>         options = 0x664908
> "f:cCm:M:b:l:n:N:rRvdDFEVhw:t:u:g:p:P:G:W:o:a:k:s:"
>
>         ret = -1
>
>         seed = 4061548656
>
>         rfd = <optimized out>
>
>         __FUNCTION__ = "main"
>
> thanks
> Andy
>
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.opensips.org/pipermail/users/attachments/20210113/d3985f22/attachment.html>