Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

2.1.1 segfault #782

Closed
ankogan opened this issue Feb 6, 2016 · 10 comments
Closed

2.1.1 segfault #782

ankogan opened this issue Feb 6, 2016 · 10 comments
Assignees
@liviuchircu
Labels
bug
Milestone
2.2.8

Comments

@ankogan
Copy link

ankogan commented Feb 6, 2016

Hi!

Got a segfault.
Backtrace:

# gdb /usr/sbin/opensips core.opensips.sig11.2472
GNU gdb (Debian 7.7.1+dfsg-5) 7.7.1
Copyright (C) 2014 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.  Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
Type "show configuration" for configuration details.
For bug reporting instructions, please see:
<http://www.gnu.org/software/gdb/bugs/>.
Find the GDB manual and other documentation resources online at:
<http://www.gnu.org/software/gdb/documentation/>.
For help, type "help".
Type "apropos word" to search for commands related to "word"...
Reading symbols from /usr/sbin/opensips...Reading symbols from /usr/lib/debug/.build-id/00/d3f7460856ef4d6666bbe206363e1b0a1ac286.debug...done.
done.
[New LWP 2472]
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
Core was generated by `/usr/sbin/opensips -P /var/run/opensips/opensips.pid -m 2048 -M 256 -u opensips'.
Program terminated with signal SIGSEGV, Segmentation fault.
#0  internal_search_ID_avp (flags=0, id=3, avp=0x3339363423313a70) at usr_avp.c:316
316                     if ( id==avp->id && (flags==0 || (flags&avp->flags))) {
(gdb) bt
#0  internal_search_ID_avp (flags=0, id=3, avp=0x3339363423313a70) at usr_avp.c:316
#1  search_next_avp (avp=0x7f2e29cd9970, val=0x0) at usr_avp.c:370
#2  0x000000000044a085 in next_branches (msg=0x7f2ea63965c0 <faked_req>) at serialize.c:399
#3  0x000000000042ae16 in do_action (a=0x7f2ea9ae8170, msg=0x7f2ea63965c0 <faked_req>) at action.c:1956
#4  0x0000000000433710 in run_action_list (a=<optimized out>, msg=0x7f2ea63965c0 <faked_req>) at action.c:169
#5  0x000000000045a5bc in eval_elem (e=0x7f2ea9ae8250, msg=0x7f2ea63965c0 <faked_req>, val=0x7fff803741c0) at route.c:1643
#6  0x0000000000459e1d in eval_expr (e=0x7f2ea9ae8250, msg=msg@entry=0x7f2ea63965c0 <faked_req>, val=val@entry=0x7fff803741c0)
    at route.c:1988
#7  0x000000000042a794 in do_assign (msg=0x7f2ea63965c0 <faked_req>, a=0x7f2ea9ae82a0) at action.c:239
#8  0x000000000042bfe3 in do_action (a=0x7f2ea9ae82a0, msg=0x7f2ea63965c0 <faked_req>) at action.c:1973
#9  0x0000000000433710 in run_action_list (a=a@entry=0x7f2ea9ae7f78, msg=msg@entry=0x7f2ea63965c0 <faked_req>) at action.c:169
#10 0x0000000000433a78 in run_actions (msg=0x7f2ea63965c0 <faked_req>, a=0x7f2ea9ae7f78) at action.c:134
#11 run_top_route (a=0x7f2ea9ae7f78, msg=0x7f2ea63965c0 <faked_req>) at action.c:209
#12 0x00007f2ea614a410 in run_failure_handlers (t=<optimized out>) at t_reply.c:581
#13 t_should_relay_response (Trans=0x7f2e34a8d4d8, new_code=3, branch=714975864, should_store=0x7fff80374a30,
    should_relay=0x7fff80374a2c, cancel_bitmap=0x7f2e29cd9958, reply=0x1ff828b8) at t_reply.c:911
#14 0x00007f2ea614a4a8 in relay_reply (t=0x7f2e34a8d4d8, p_msg=0x7f2ea9afc520, branch=2, msg_status=404,
    cancel_bitmap=0x7f2e23daf190) at t_reply.c:1125
#15 0x00007f2ea614da3d in reply_received (p_msg=0x7f2ea9afc520) at t_reply.c:1505
#16 0x0000000000426ebc in forward_reply (msg=0x7f2ea9afc520) at forward.c:517
#17 0x0000000000436098 in receive_msg (
    buf=0x7d08c0 <buf> "SIP/2.0 404 Not Found\r\nVia: SIP/2.0/UDP 192.168.0.1:5060;branch=z9hG4bK5009.3df681a3.2\r\nFrom: 93293147305 <sip:93293147305@192.168.0.1;user=phone>;tag=9501SIPpTag004160354\r\nTo: 11#17151248386 <sip:1#1"..., len=0,
    rcv_info=0x3) at receive.c:243
#18 0x0000000000519ce3 in udp_read_req (si=<optimized out>, bytes_read=<optimized out>) at net/proto_udp/proto_udp.c:190
#19 0x00000000005083a7 in handle_io (fm=<optimized out>, fm=<optimized out>, fm=<optimized out>, idx=<optimized out>,
    event_type=<optimized out>) at net/net_udp.c:260
#20 io_wait_loop_epoll (h=<optimized out>, t=<optimized out>, repeat=<optimized out>) at net/../io_wait_loop.h:190
#21 udp_rcv_loop (si=0x1) at net/net_udp.c:308
#22 0x000000000050940b in udp_start_processes (chd_rank=chd_rank@entry=0x7bd57c <chd_rank>,
    startup_done=startup_done@entry=0x0) at net/net_udp.c:448
#23 0x0000000000419d85 in main_loop () at main.c:722
---Type <return> to continue, or q <return> to quit---
#24 main (argc=<optimized out>, argv=<optimized out>) at main.c:1259
(gdb)
@liviuchircu
Copy link
Member

Looks like some memory is being overwritten. Does the following piece of a string mean anything in your script logic?

   ...3964#1:p...

Also, could you provide the exact script file you used to cause this behaviour? If privacy is a concern, you may email it to liviu@opensips.org

@liviuchircu liviuchircu self-assigned this Feb 8, 2016
@ankogan
Copy link
Author

ankogan commented Feb 8, 2016

Hi!

Yes, looks like memory error. Also I get errors like this:
WARNING:core:timer_ticker: timer task already schedualed for 1638860 ms (now 1701330 ms), it may overlap..
And I see 2 process segfaulted at the same time - the first backtrace I've already sent and this is the second:
Core was generated by `/usr/sbin/opensips -P /var/run/opensips/opensips.pid -m 2048 -M 256 -u opensips'.
Program terminated with signal SIGSEGV, Segmentation fault.
#0 0x00007f2e9817b9a1 in unref_dlg (dlg=0x7f2e19008ca8, cnt=1) at dlg_hash.c:759
759 d_entry = &(d_table->entries[dlg->h_entry]);
(gdb) bt full
#0 0x00007f2e9817b9a1 in unref_dlg (dlg=0x7f2e19008ca8, cnt=1) at dlg_hash.c:759
d_entry = 0x14c0
FUNCTION = "unref_dlg"
#1 0x00007f2e9948c483 in empty_tmcb_list (head=head@entry=0x7f2e184dd280) at t_hooks.c:53
cbp = 0x7f2e17dc96a0
cbp_tmp = 0x7f2e1a203610
#2 0x00007f2e9946e06e in free_cell (dead_cell=0x7f2e184dd210) at h_table.c:127
b =
i =
rpl =
tt =
foo =
p =
#3 0x00007f2e994702d0 in free_hash_table () at h_table.c:375
p_cell =
tmp_cell = 0x0
i = 218
#4 0x00007f2e9946d515 in tm_shutdown () at t_funcs.c:91
FUNCTION = "tm_shutdown"
#5 0x00000000004914a9 in destroy_modules () at sr_module.c:527
t = 0x7f2e9cdeb848
foo = 0x7f2e9cdeb768
FUNCTION = "destroy_modules"
#6 0x000000000048c961 in cleanup (show_status=show_status@entry=1) at main.c:308
FUNCTION = "cleanup"
#7 0x000000000048d452 in handle_sigs () at main.c:503
chld =
chld_status = 139
overall_status = 139
i =
do_exit = 1
FUNCTION = "handle_sigs"
---Type to continue, or q to quit---
#8 0x0000000000419ef7 in main_loop () at main.c:756
startup_done =
chd_rank = 128
#9 main (argc=, argv=) at main.c:1259
cfg_log_stderr =
cfg_stream =
c =
r =
tmp = 0x7fffcadcbf5b ""
tmp_len =
port =
proto =
options = 0x542728 "f:cCm:M:b:l:n:N:rRvdDFETSVhw:t:u:g:P:G:W:o:"
seed = 2360128054
FUNCTION = "main"
(gdb)

I've sent the script to your e-mail.

@ankogan
Copy link
Author

ankogan commented Feb 8, 2016

Oh, sorry... I don't know how to insert text without formatting....
Simple bt:
Core was generated by `/usr/sbin/opensips -P /var/run/opensips/opensips.pid -m 2048 -M 256 -u opensips'.
Program terminated with signal SIGSEGV, Segmentation fault.
#0 0x00007f2e9817b9a1 in unref_dlg (dlg=0x7f2e19008ca8, cnt=1) at dlg_hash.c:759
759 d_entry = &(d_table->entries[dlg->h_entry]);
(gdb) bt
#0 0x00007f2e9817b9a1 in unref_dlg (dlg=0x7f2e19008ca8, cnt=1) at dlg_hash.c:759
#1 0x00007f2e9948c483 in empty_tmcb_list (head=head@entry=0x7f2e184dd280) at t_hooks.c:53
#2 0x00007f2e9946e06e in free_cell (dead_cell=0x7f2e184dd210) at h_table.c:127
#3 0x00007f2e994702d0 in free_hash_table () at h_table.c:375
#4 0x00007f2e9946d515 in tm_shutdown () at t_funcs.c:91
#5 0x00000000004914a9 in destroy_modules () at sr_module.c:527
#6 0x000000000048c961 in cleanup (show_status=show_status@entry=1) at main.c:308
#7 0x000000000048d452 in handle_sigs () at main.c:503
#8 0x0000000000419ef7 in main_loop () at main.c:756
#9 main (argc=, argv=) at main.c:1259
(gdb) p d_table
$1 = (struct dlg_table *) 0x0

@bogdan-iancu
Copy link
Member

@ankogan , please upgrade first to latest 2.1.2 - maybe this bug was already fixed.
BTW, was this a singular crash or can you reproduce it ?

@ankogan
Copy link
Author

ankogan commented Feb 10, 2016

@bogdan-iancu, this is a reproduceable crash. And it's resulted in two same core files from two processes as I described before.

@bogdan-iancu
Copy link
Member

@ankogan , have you upgraded to the latest 2.1 ? (2.1.2) Some bugs in that area were fixed in the 2.1.2 release.

@ankogan
Copy link
Author

ankogan commented Feb 18, 2016

@bogdan-iancu , I've moved to 2.2 due to "ms_duration" in acc module. And I've got the similar error. It happends rarely - the switch have been working for 2 days before error with 60 CPS incoming and ~200 CPS outgoing.
This morning I've got two cores:

root@testfarm ~ # ll /home/corefiles/
total 4197984
-rw------- 1 opensips opensips 2418343936 Feb 18 02:28 core.opensips.sig11.13638
-rw------- 1 opensips opensips 2418343936 Feb 18 02:30 core.opensips.sig6.13552
root@testfarm ~ #

syslog:

root@testfarm ~ # grep opensips /var/log/syslog.1|egrep '18 02:(28|29|30)'
Feb 18 02:28:16 testfarm kernel: [3855136.903704] traps: opensips[13638] general protection ip:48e4d9 sp:7ffc986fa0c8 error:0 in opensips[400000+18e000]
Feb 18 02:28:17 testfarm /usr/sbin/opensips[13578]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:17 testfarm /usr/sbin/opensips[13648]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:17 testfarm /usr/sbin/opensips[13649]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 70000 us delay in execution
Feb 18 02:28:17 testfarm /usr/sbin/opensips[13570]: WARNING:core:handle_timer_job: timer job <tm-timer> has a 70000 us delay in execution
Feb 18 02:28:17 testfarm /usr/sbin/opensips[13654]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 70000 us delay in execution
Feb 18 02:28:17 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107253780 ms (now 107253880 ms), it may overlap..
Feb 18 02:28:17 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107253880 ms (now 107253980 ms), it may overlap..
Feb 18 02:28:17 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107253980 ms (now 107254080 ms), it may overlap..
Feb 18 02:28:18 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107254080 ms (now 107254180 ms), it may overlap..
Feb 18 02:28:18 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107254180 ms (now 107254280 ms), it may overlap..
Feb 18 02:28:18 testfarm /usr/sbin/opensips[13584]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 80000 us delay in execution
Feb 18 02:28:18 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107254280 ms (now 107254380 ms), it may overlap..
Feb 18 02:28:18 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107254380 ms (now 107254480 ms), it may overlap..
Feb 18 02:28:21 testfarm /usr/sbin/opensips[13643]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 90000 us delay in execution
Feb 18 02:28:21 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107257250 ms (now 107257350 ms), it may overlap..
Feb 18 02:28:21 testfarm /usr/sbin/opensips[13619]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:21 testfarm /usr/sbin/opensips[13648]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107257390000 us delay in execution
Feb 18 02:28:21 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107257450 ms (now 107257550 ms), it may overlap..
Feb 18 02:28:21 testfarm /usr/sbin/opensips[13564]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 30000 us delay in execution
Feb 18 02:28:21 testfarm /usr/sbin/opensips[13591]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 30000 us delay in execution
Feb 18 02:28:23 testfarm /usr/sbin/opensips[13598]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:23 testfarm /usr/sbin/opensips[13578]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 20000 us delay in execution
Feb 18 02:28:23 testfarm /usr/sbin/opensips[13636]: WARNING:core:handle_timer_job: timer job <tm-timer> has a 20000 us delay in execution
Feb 18 02:28:23 testfarm /usr/sbin/opensips[13641]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 20000 us delay in execution
Feb 18 02:28:23 testfarm /usr/sbin/opensips[13616]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:23 testfarm /usr/sbin/opensips[13565]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 90000 us delay in execution
Feb 18 02:28:23 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107259920 ms (now 107260020 ms), it may overlap..
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107260020 ms (now 107260120 ms), it may overlap..
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13579]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13576]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13573]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107260220 ms (now 107260320 ms), it may overlap..
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107260320 ms (now 107260420 ms), it may overlap..
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13632]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13636]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13598]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107260520 ms (now 107260620 ms), it may overlap..
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107260620 ms (now 107260720 ms), it may overlap..
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13573]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13564]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13644]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 120000 us delay in execution
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13610]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 120000 us delay in execution
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13576]: WARNING:core:handle_timer_job: timer job <tm-timer> has a 120000 us delay in execution
Feb 18 02:28:24 testfarm /usr/sbin/opensips[13592]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:26 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107262310 ms (now 107262410 ms), it may overlap..
Feb 18 02:28:26 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107262410 ms (now 107262510 ms), it may overlap..
Feb 18 02:28:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107263700 ms (now 107263800 ms), it may overlap..
Feb 18 02:28:27 testfarm /usr/sbin/opensips[13582]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 90000 us delay in execution
Feb 18 02:28:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107263800 ms (now 107263900 ms), it may overlap..
Feb 18 02:28:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107263900 ms (now 107264000 ms), it may overlap..
Feb 18 02:28:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107264000 ms (now 107264100 ms), it may overlap..
Feb 18 02:28:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107264390 ms (now 107264490 ms), it may overlap..
Feb 18 02:28:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107264690 ms (now 107264790 ms), it may overlap..
Feb 18 02:28:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107264790 ms (now 107264890 ms), it may overlap..
Feb 18 02:28:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107264890 ms (now 107264990 ms), it may overlap..
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107264990 ms (now 107265090 ms), it may overlap..
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107265090 ms (now 107265190 ms), it may overlap..
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13579]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 30000 us delay in execution
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13595]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 30000 us delay in execution
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107265190 ms (now 107265290 ms), it may overlap..
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107265290 ms (now 107265390 ms), it may overlap..
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13624]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107265390 ms (now 107265490 ms), it may overlap..
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107265490 ms (now 107265590 ms), it may overlap..
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107264590 ms (now 107265590 ms), it may overlap..
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13583]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 90000 us delay in execution
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13635]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 90000 us delay in execution
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13648]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 90000 us delay in execution
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107265590 ms (now 107265690 ms), it may overlap..
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107265690 ms (now 107265790 ms), it may overlap..
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13565]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 30000 us delay in execution
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13601]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 30000 us delay in execution
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107265790 ms (now 107265890 ms), it may overlap..
Feb 18 02:28:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107265890 ms (now 107265990 ms), it may overlap..
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13573]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 60000 us delay in execution
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13651]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 60000 us delay in execution
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107265990 ms (now 107266090 ms), it may overlap..
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107266090 ms (now 107266190 ms), it may overlap..
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107266190 ms (now 107266290 ms), it may overlap..
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13655]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 90000 us delay in execution
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13564]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 90000 us delay in execution
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13636]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 90000 us delay in execution
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107266290 ms (now 107266380 ms), it may overlap..
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107266380 ms (now 107266480 ms), it may overlap..
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107266480 ms (now 107266580 ms), it may overlap..
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107264590 ms (now 107266580 ms), it may overlap..
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13627]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 100000 us delay in execution
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13570]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 100000 us delay in execution
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13574]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 100000 us delay in execution
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13582]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 100000 us delay in execution
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13632]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 100000 us delay in execution
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107266580 ms (now 107266680 ms), it may overlap..
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107266680 ms (now 107266780 ms), it may overlap..
Feb 18 02:28:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107266780 ms (now 107266880 ms), it may overlap..
Feb 18 02:28:32 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107268660 ms (now 107268760 ms), it may overlap..
Feb 18 02:28:32 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107268760 ms (now 107268860 ms), it may overlap..
Feb 18 02:28:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107268860 ms (now 107268960 ms), it may overlap..
Feb 18 02:28:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107268960 ms (now 107269060 ms), it may overlap..
Feb 18 02:28:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107269060 ms (now 107269160 ms), it may overlap..
Feb 18 02:28:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107269160 ms (now 107269260 ms), it may overlap..
Feb 18 02:28:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107269260 ms (now 107269360 ms), it may overlap..
Feb 18 02:28:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107269360 ms (now 107269460 ms), it may overlap..
Feb 18 02:28:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107269460 ms (now 107269560 ms), it may overlap..
Feb 18 02:28:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107268570 ms (now 107269560 ms), it may overlap..
Feb 18 02:28:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107269560 ms (now 107269660 ms), it may overlap..
Feb 18 02:28:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107269660 ms (now 107269760 ms), it may overlap..
Feb 18 02:28:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107269760 ms (now 107269860 ms), it may overlap..
Feb 18 02:28:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107269860 ms (now 107269960 ms), it may overlap..
Feb 18 02:28:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107269960 ms (now 107270060 ms), it may overlap..
Feb 18 02:28:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107270060 ms (now 107270160 ms), it may overlap..
Feb 18 02:28:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107270160 ms (now 107270260 ms), it may overlap..
Feb 18 02:28:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107270260 ms (now 107270360 ms), it may overlap..
Feb 18 02:28:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107270360 ms (now 107270460 ms), it may overlap..
Feb 18 02:28:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107270460 ms (now 107270560 ms), it may overlap..
Feb 18 02:28:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107269560 ms (now 107270560 ms), it may overlap..
Feb 18 02:28:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107268570 ms (now 107270560 ms), it may overlap..
Feb 18 02:28:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107269560 ms (now 107270560 ms), it may overlap..
Feb 18 02:28:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107270560 ms (now 107270660 ms), it may overlap..
Feb 18 02:28:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107270660 ms (now 107270760 ms), it may overlap..
Feb 18 02:28:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107270760 ms (now 107270860 ms), it may overlap..
Feb 18 02:28:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107270860 ms (now 107270960 ms), it may overlap..
Feb 18 02:28:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107270960 ms (now 107271060 ms), it may overlap..
Feb 18 02:28:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107271060 ms (now 107271160 ms), it may overlap..
Feb 18 02:28:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107271160 ms (now 107271260 ms), it may overlap..
Feb 18 02:28:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107271260 ms (now 107271360 ms), it may overlap..
Feb 18 02:28:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107271360 ms (now 107271460 ms), it may overlap..
Feb 18 02:28:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107271460 ms (now 107271560 ms), it may overlap..
Feb 18 02:28:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107269560 ms (now 107271560 ms), it may overlap..
Feb 18 02:28:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107268570 ms (now 107271560 ms), it may overlap..
Feb 18 02:28:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107269560 ms (now 107271560 ms), it may overlap..
Feb 18 02:28:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107271560 ms (now 107271650 ms), it may overlap..
Feb 18 02:28:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107271650 ms (now 107271750 ms), it may overlap..
Feb 18 02:28:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107271750 ms (now 107271850 ms), it may overlap..
Feb 18 02:28:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107271850 ms (now 107271950 ms), it may overlap..
Feb 18 02:28:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107271950 ms (now 107272050 ms), it may overlap..
Feb 18 02:28:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107272050 ms (now 107272150 ms), it may overlap..
Feb 18 02:28:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107272150 ms (now 107272250 ms), it may overlap..
Feb 18 02:28:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107272250 ms (now 107272350 ms), it may overlap..
Feb 18 02:28:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107272350 ms (now 107272450 ms), it may overlap..
Feb 18 02:28:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107272450 ms (now 107272550 ms), it may overlap..
Feb 18 02:28:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107269560 ms (now 107272550 ms), it may overlap..
Feb 18 02:28:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107268570 ms (now 107272550 ms), it may overlap..
Feb 18 02:28:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107269560 ms (now 107272550 ms), it may overlap..
Feb 18 02:28:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107272550 ms (now 107272650 ms), it may overlap..
Feb 18 02:28:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107272650 ms (now 107272750 ms), it may overlap..
Feb 18 02:28:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107272750 ms (now 107272850 ms), it may overlap..
Feb 18 02:28:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107272850 ms (now 107272950 ms), it may overlap..
Feb 18 02:28:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107272950 ms (now 107273050 ms), it may overlap..
Feb 18 02:28:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107273050 ms (now 107273150 ms), it may overlap..
Feb 18 02:28:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107273150 ms (now 107273250 ms), it may overlap..
Feb 18 02:28:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107273250 ms (now 107273350 ms), it may overlap..
Feb 18 02:28:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107273350 ms (now 107273450 ms), it may overlap..
Feb 18 02:28:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107273450 ms (now 107273550 ms), it may overlap..
Feb 18 02:28:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107269560 ms (now 107273550 ms), it may overlap..
Feb 18 02:28:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107268570 ms (now 107273550 ms), it may overlap..
Feb 18 02:28:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107269560 ms (now 107273550 ms), it may overlap..
Feb 18 02:28:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107273550 ms (now 107273650 ms), it may overlap..
Feb 18 02:28:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107273650 ms (now 107273750 ms), it may overlap..
Feb 18 02:28:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107273750 ms (now 107273850 ms), it may overlap..
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107273850 ms (now 107273950 ms), it may overlap..
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107273950 ms (now 107274050 ms), it may overlap..
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107274050 ms (now 107274150 ms), it may overlap..
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13598]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 4600000 us delay in execution
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13570]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 4600000 us delay in execution
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107274150 ms (now 107274250 ms), it may overlap..
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107274250 ms (now 107274350 ms), it may overlap..
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107274350 ms (now 107274450 ms), it may overlap..
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107274450 ms (now 107274550 ms), it may overlap..
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107268570 ms (now 107274550 ms), it may overlap..
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13632]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 90000 us delay in execution
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13652]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 90000 us delay in execution
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107274550 ms (now 107274650 ms), it may overlap..
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13621]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 80000 us delay in execution
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13636]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 180000 us delay in execution
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107274650 ms (now 107274740 ms), it may overlap..
Feb 18 02:28:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107274740 ms (now 107274840 ms), it may overlap..
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107274840 ms (now 107274940 ms), it may overlap..
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107274940 ms (now 107275040 ms), it may overlap..
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13636]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 500000 us delay in execution
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107275040 ms (now 107275140 ms), it may overlap..
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107275140 ms (now 107275240 ms), it may overlap..
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107275240 ms (now 107275340 ms), it may overlap..
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107275340 ms (now 107275440 ms), it may overlap..
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107275440 ms (now 107275540 ms), it may overlap..
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107268570 ms (now 107275540 ms), it may overlap..
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13636]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 60000 us delay in execution
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13650]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 60000 us delay in execution
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13604]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107275610000 us delay in execution
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13604]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107275610000 us delay in execution
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13604]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107275610000 us delay in execution
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13604]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107275610000 us delay in execution
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13604]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107275610000 us delay in execution
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13604]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107275610000 us delay in execution
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13624]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107275610000 us delay in execution
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13624]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107275610000 us delay in execution
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13624]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 70000 us delay in execution
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13624]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 70000 us delay in execution
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107275640 ms (now 107275740 ms), it may overlap..
Feb 18 02:28:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107275740 ms (now 107275840 ms), it may overlap..
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107275840 ms (now 107275940 ms), it may overlap..
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107275940 ms (now 107276040 ms), it may overlap..
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13576]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13579]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13590]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13570]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13644]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107276340 ms (now 107276440 ms), it may overlap..
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13616]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 30000 us delay in execution
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13599]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107276470000 us delay in execution
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107276540 ms (now 107276630 ms), it may overlap..
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13574]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13590]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 110000 us delay in execution
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13581]: WARNING:core:handle_timer_job: timer job <tm-timer> has a 110000 us delay in execution
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13590]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 110000 us delay in execution
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13561]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107276730 ms (now 107276830 ms), it may overlap..
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13598]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:40 testfarm /usr/sbin/opensips[13599]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107276830 ms (now 107276930 ms), it may overlap..
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107276930 ms (now 107277030 ms), it may overlap..
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13643]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 80000 us delay in execution
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13561]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 80000 us delay in execution
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107277030 ms (now 107277130 ms), it may overlap..
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107277130 ms (now 107277230 ms), it may overlap..
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107277230 ms (now 107277330 ms), it may overlap..
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107277330 ms (now 107277430 ms), it may overlap..
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13574]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 30000 us delay in execution
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107277430 ms (now 107277530 ms), it may overlap..
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107276540 ms (now 107277530 ms), it may overlap..
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13601]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 70000 us delay in execution
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13576]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 70000 us delay in execution
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107277530 ms (now 107277630 ms), it may overlap..
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107277630 ms (now 107277730 ms), it may overlap..
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107277730 ms (now 107277830 ms), it may overlap..
Feb 18 02:28:41 testfarm /usr/sbin/opensips[13590]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 60000 us delay in execution
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107277830 ms (now 107277930 ms), it may overlap..
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107277930 ms (now 107278030 ms), it may overlap..
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13657]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 90000 us delay in execution
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13644]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 90000 us delay in execution
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107278030 ms (now 107278130 ms), it may overlap..
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107278130 ms (now 107278230 ms), it may overlap..
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13601]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 80000 us delay in execution
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13610]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 80000 us delay in execution
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107278230 ms (now 107278330 ms), it may overlap..
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107278330 ms (now 107278430 ms), it may overlap..
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107278430 ms (now 107278530 ms), it may overlap..
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107276540 ms (now 107278530 ms), it may overlap..
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13573]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 90000 us delay in execution
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13627]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 90000 us delay in execution
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13586]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 90000 us delay in execution
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13678]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 90000 us delay in execution
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13650]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 90000 us delay in execution
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107278530 ms (now 107278630 ms), it may overlap..
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107278630 ms (now 107278730 ms), it may overlap..
Feb 18 02:28:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107278730 ms (now 107278830 ms), it may overlap..
Feb 18 02:28:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107278830 ms (now 107278930 ms), it may overlap..
Feb 18 02:28:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107278930 ms (now 107279030 ms), it may overlap..
Feb 18 02:28:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107279030 ms (now 107279130 ms), it may overlap..
Feb 18 02:28:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107279130 ms (now 107279230 ms), it may overlap..
Feb 18 02:28:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107279230 ms (now 107279330 ms), it may overlap..
Feb 18 02:28:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107279330 ms (now 107279430 ms), it may overlap..
Feb 18 02:28:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107279430 ms (now 107279520 ms), it may overlap..
Feb 18 02:28:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107276540 ms (now 107279530 ms), it may overlap..
Feb 18 02:28:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107279530 ms (now 107279620 ms), it may overlap..
Feb 18 02:28:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107279620 ms (now 107279720 ms), it may overlap..
Feb 18 02:28:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107279720 ms (now 107279820 ms), it may overlap..
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107279820 ms (now 107279920 ms), it may overlap..
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107279920 ms (now 107280020 ms), it may overlap..
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107280020 ms (now 107280120 ms), it may overlap..
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13646]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13576]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13649]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107280120 ms (now 107280220 ms), it may overlap..
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13652]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13564]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13650]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13648]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13653]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13582]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13565]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 760000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13570]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 760000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13597]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13562]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13589]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13584]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13640]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13567]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13641]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107280220 ms (now 107280320 ms), it may overlap..
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107280320 ms (now 107280420 ms), it may overlap..
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107280420 ms (now 107280520 ms), it may overlap..
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-dbupdate> already schedualed for 107250700 ms (now 107280520 ms), it may overlap..
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107276540 ms (now 107280520 ms), it may overlap..
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107280520 ms (now 107280620 ms), it may overlap..
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13619]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13678]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13635]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13565]: WARNING:core:handle_timer_job: timer job <dlg-options-pinger> has a 140000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13588]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 140000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13607]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 140000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13570]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107280620 ms (now 107280720 ms), it may overlap..
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13595]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107280720 ms (now 107280820 ms), it may overlap..
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107280820 ms (now 107280920 ms), it may overlap..
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13588]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13565]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107280920 ms (now 107281020 ms), it may overlap..
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107281020 ms (now 107281120 ms), it may overlap..
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107281120 ms (now 107281220 ms), it may overlap..
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13592]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13593]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13613]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107281220 ms (now 107281320 ms), it may overlap..
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13604]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 80000 us delay in execution
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107281320 ms (now 107281420 ms), it may overlap..
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107281420 ms (now 107281520 ms), it may overlap..
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107276540 ms (now 107281520 ms), it may overlap..
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13591]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13624]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13654]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 70000 us delay in execution
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13645]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 70000 us delay in execution
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107281520 ms (now 107281620 ms), it may overlap..
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107281620 ms (now 107281720 ms), it may overlap..
Feb 18 02:28:45 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107281720 ms (now 107281820 ms), it may overlap..
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107281820 ms (now 107281920 ms), it may overlap..
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13578]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 30000 us delay in execution
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107281920 ms (now 107282020 ms), it may overlap..
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13654]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107282020 ms (now 107282120 ms), it may overlap..
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107282120 ms (now 107282220 ms), it may overlap..
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13607]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 80000 us delay in execution
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13645]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 80000 us delay in execution
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107282220 ms (now 107282320 ms), it may overlap..
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107282320 ms (now 107282420 ms), it may overlap..
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107282420 ms (now 107282520 ms), it may overlap..
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107276540 ms (now 107282520 ms), it may overlap..
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13647]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13632]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13651]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 40000 us delay in execution
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13616]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 40000 us delay in execution
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13655]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 40000 us delay in execution
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107282520 ms (now 107282620 ms), it may overlap..
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107282620 ms (now 107282720 ms), it may overlap..
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107282720 ms (now 107282820 ms), it may overlap..
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13655]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 30000 us delay in execution
Feb 18 02:28:46 testfarm /usr/sbin/opensips[13616]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 30000 us delay in execution
Feb 18 02:28:47 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107282820 ms (now 107282920 ms), it may overlap..
Feb 18 02:28:47 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107282920 ms (now 107283010 ms), it may overlap..
Feb 18 02:28:47 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107283010 ms (now 107283110 ms), it may overlap..
Feb 18 02:28:47 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107283110 ms (now 107283210 ms), it may overlap..
Feb 18 02:28:47 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107283210 ms (now 107283310 ms), it may overlap..
Feb 18 02:28:47 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107283310 ms (now 107283410 ms), it may overlap..
Feb 18 02:28:47 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107283410 ms (now 107283510 ms), it may overlap..
Feb 18 02:28:47 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107276540 ms (now 107283510 ms), it may overlap..
Feb 18 02:28:47 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107283510 ms (now 107283610 ms), it may overlap..
Feb 18 02:28:47 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107283610 ms (now 107283710 ms), it may overlap..
Feb 18 02:28:47 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107283710 ms (now 107283810 ms), it may overlap..
Feb 18 02:28:48 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107283810 ms (now 107283910 ms), it may overlap..
Feb 18 02:28:48 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107283910 ms (now 107284010 ms), it may overlap..
Feb 18 02:28:48 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107284010 ms (now 107284110 ms), it may overlap..
Feb 18 02:28:48 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107284110 ms (now 107284210 ms), it may overlap..
Feb 18 02:28:48 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107284210 ms (now 107284310 ms), it may overlap..
Feb 18 02:28:48 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107284310 ms (now 107284410 ms), it may overlap..
Feb 18 02:28:48 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107284410 ms (now 107284510 ms), it may overlap..
Feb 18 02:28:48 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107283510 ms (now 107284510 ms), it may overlap..
Feb 18 02:28:48 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107276540 ms (now 107284510 ms), it may overlap..
Feb 18 02:28:48 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107283510 ms (now 107284510 ms), it may overlap..
Feb 18 02:28:48 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107284510 ms (now 107284610 ms), it may overlap..
Feb 18 02:28:48 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107284610 ms (now 107284710 ms), it may overlap..
Feb 18 02:28:48 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107284710 ms (now 107284810 ms), it may overlap..
Feb 18 02:28:49 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107284810 ms (now 107284910 ms), it may overlap..
Feb 18 02:28:49 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107284910 ms (now 107285010 ms), it may overlap..
Feb 18 02:28:49 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107285010 ms (now 107285110 ms), it may overlap..
Feb 18 02:28:49 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107285110 ms (now 107285210 ms), it may overlap..
Feb 18 02:28:49 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107285210 ms (now 107285310 ms), it may overlap..
Feb 18 02:28:49 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107285310 ms (now 107285410 ms), it may overlap..
Feb 18 02:28:49 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107285410 ms (now 107285510 ms), it may overlap..
Feb 18 02:28:49 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107283510 ms (now 107285510 ms), it may overlap..
Feb 18 02:28:49 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107276540 ms (now 107285510 ms), it may overlap..
Feb 18 02:28:49 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107283510 ms (now 107285510 ms), it may overlap..
Feb 18 02:28:49 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107285510 ms (now 107285610 ms), it may overlap..
Feb 18 02:28:49 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107285610 ms (now 107285710 ms), it may overlap..
Feb 18 02:28:49 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107285710 ms (now 107285810 ms), it may overlap..
Feb 18 02:28:50 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107285810 ms (now 107285910 ms), it may overlap..
Feb 18 02:28:50 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107285910 ms (now 107286010 ms), it may overlap..
Feb 18 02:28:50 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107286010 ms (now 107286110 ms), it may overlap..
Feb 18 02:28:50 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107286110 ms (now 107286210 ms), it may overlap..
Feb 18 02:28:50 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107286210 ms (now 107286310 ms), it may overlap..
Feb 18 02:28:50 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107286310 ms (now 107286410 ms), it may overlap..
Feb 18 02:28:50 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107286410 ms (now 107286510 ms), it may overlap..
Feb 18 02:28:50 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107283510 ms (now 107286510 ms), it may overlap..
Feb 18 02:28:50 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107276540 ms (now 107286510 ms), it may overlap..
Feb 18 02:28:50 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107283510 ms (now 107286510 ms), it may overlap..
Feb 18 02:28:50 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107286510 ms (now 107286600 ms), it may overlap..
Feb 18 02:28:50 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107286600 ms (now 107286700 ms), it may overlap..
Feb 18 02:28:50 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107286700 ms (now 107286800 ms), it may overlap..
Feb 18 02:28:51 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107286800 ms (now 107286900 ms), it may overlap..
Feb 18 02:28:51 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107286900 ms (now 107287000 ms), it may overlap..
Feb 18 02:28:51 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107287000 ms (now 107287100 ms), it may overlap..
Feb 18 02:28:51 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107287100 ms (now 107287200 ms), it may overlap..
Feb 18 02:28:51 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107287200 ms (now 107287300 ms), it may overlap..
Feb 18 02:28:51 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107287300 ms (now 107287400 ms), it may overlap..
Feb 18 02:28:51 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107287400 ms (now 107287500 ms), it may overlap..
Feb 18 02:28:51 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107283510 ms (now 107287500 ms), it may overlap..
Feb 18 02:28:51 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107276540 ms (now 107287500 ms), it may overlap..
Feb 18 02:28:51 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107283510 ms (now 107287500 ms), it may overlap..
Feb 18 02:28:51 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107287500 ms (now 107287600 ms), it may overlap..
Feb 18 02:28:51 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107287600 ms (now 107287700 ms), it may overlap..
Feb 18 02:28:51 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107287700 ms (now 107287800 ms), it may overlap..
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107287800 ms (now 107287900 ms), it may overlap..
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107287900 ms (now 107288000 ms), it may overlap..
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107288000 ms (now 107288100 ms), it may overlap..
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107288100 ms (now 107288200 ms), it may overlap..
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107288200 ms (now 107288300 ms), it may overlap..
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107288300 ms (now 107288400 ms), it may overlap..
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107288400 ms (now 107288500 ms), it may overlap..
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107283510 ms (now 107288500 ms), it may overlap..
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107276540 ms (now 107288500 ms), it may overlap..
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107283510 ms (now 107288500 ms), it may overlap..
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107288500 ms (now 107288600 ms), it may overlap..
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107288600 ms (now 107288700 ms), it may overlap..
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13572]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288700000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13561]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288700000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13567]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13588]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13567]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13589]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13579]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13589]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13575]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 5200000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13579]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 5200000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13589]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13579]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13589]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13579]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13589]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13579]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13589]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13572]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13579]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13601]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13597]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13599]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13561]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13590]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13575]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13562]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13585]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13579]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13593]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13595]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13576]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13574]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13570]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13597]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13591]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13601]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13599]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13580]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13561]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13590]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13592]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13575]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13562]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13585]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13579]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13593]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13576]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13574]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13570]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13597]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13591]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13601]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13599]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13580]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13592]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13575]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13562]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13585]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13579]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13578]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13589]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:52 testfarm /usr/sbin/opensips[13572]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 107288710000 us delay in execution
Feb 18 02:28:53 testfarm /usr/sbin/opensips[13564]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:53 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107289490 ms (now 107289590 ms), it may overlap..
Feb 18 02:28:53 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107289590 ms (now 107289690 ms), it may overlap..
Feb 18 02:28:53 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107289690 ms (now 107289790 ms), it may overlap..
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107289790 ms (now 107289890 ms), it may overlap..
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107289890 ms (now 107289990 ms), it may overlap..
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107289990 ms (now 107290090 ms), it may overlap..
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107290090 ms (now 107290190 ms), it may overlap..
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107290190 ms (now 107290290 ms), it may overlap..
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107290290 ms (now 107290380 ms), it may overlap..
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107290380 ms (now 107290480 ms), it may overlap..
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107289490 ms (now 107290480 ms), it may overlap..
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107290480 ms), it may overlap..
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107289490 ms (now 107290480 ms), it may overlap..
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107290480 ms (now 107290580 ms), it may overlap..
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107290580 ms (now 107290680 ms), it may overlap..
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107290680 ms (now 107290780 ms), it may overlap..
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13587]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13607]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13621]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 1340000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13649]: WARNING:core:handle_timer_job: timer job <tm-timer> has a 1340000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13619]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 1340000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13599]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13576]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13561]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13586]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13575]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13578]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13647]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13616]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13593]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13598]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13601]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:54 testfarm /usr/sbin/opensips[13642]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107290880 ms (now 107290980 ms), it may overlap..
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13562]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 80000 us delay in execution
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13565]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 80000 us delay in execution
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107290980 ms (now 107291080 ms), it may overlap..
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107291080 ms (now 107291180 ms), it may overlap..
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107291180 ms (now 107291280 ms), it may overlap..
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107291280 ms (now 107291370 ms), it may overlap..
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13591]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13597]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13567]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13592]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107291370 ms (now 107291470 ms), it may overlap..
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107291470 ms), it may overlap..
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107291470 ms (now 107291570 ms), it may overlap..
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107291570 ms (now 107291670 ms), it may overlap..
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13587]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 210000 us delay in execution
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13640]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 250000 us delay in execution
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13586]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13598]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107291670 ms (now 107291770 ms), it may overlap..
Feb 18 02:28:55 testfarm /usr/sbin/opensips[13599]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107291770 ms (now 107291870 ms), it may overlap..
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107291870 ms (now 107291970 ms), it may overlap..
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107291970 ms (now 107292070 ms), it may overlap..
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107292070 ms (now 107292170 ms), it may overlap..
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107292170 ms (now 107292270 ms), it may overlap..
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13650]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13574]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107292270 ms (now 107292370 ms), it may overlap..
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13635]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 80000 us delay in execution
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107292370 ms (now 107292470 ms), it may overlap..
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107292470 ms), it may overlap..
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107292470 ms (now 107292570 ms), it may overlap..
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13589]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13653]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 170000 us delay in execution
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13607]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 170000 us delay in execution
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13584]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107292570 ms (now 107292670 ms), it may overlap..
Feb 18 02:28:56 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107292670 ms (now 107292770 ms), it may overlap..
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107292770 ms (now 107292870 ms), it may overlap..
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107292870 ms (now 107292970 ms), it may overlap..
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107292970 ms (now 107293070 ms), it may overlap..
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107293070 ms (now 107293170 ms), it may overlap..
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107293170 ms (now 107293270 ms), it may overlap..
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13564]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13590]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13648]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107293270 ms (now 107293370 ms), it may overlap..
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107293370 ms (now 107293470 ms), it may overlap..
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107293470 ms), it may overlap..
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13604]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 80000 us delay in execution
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107293470 ms (now 107293570 ms), it may overlap..
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107293570 ms (now 107293670 ms), it may overlap..
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13610]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13579]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 220000 us delay in execution
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13657]: WARNING:core:handle_timer_job: timer job <blcore-expire> has a 220000 us delay in execution
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13645]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13621]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 20000 us delay in execution
Feb 18 02:28:57 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107293670 ms (now 107293770 ms), it may overlap..
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107293770 ms (now 107293870 ms), it may overlap..
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107293870 ms (now 107293970 ms), it may overlap..
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107293970 ms (now 107294070 ms), it may overlap..
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107294070 ms (now 107294170 ms), it may overlap..
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107294170 ms (now 107294270 ms), it may overlap..
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107294270 ms (now 107294370 ms), it may overlap..
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13580]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13575]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13595]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13641]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13578]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13636]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13643]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 70000 us delay in execution
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107294370 ms (now 107294470 ms), it may overlap..
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107294470 ms), it may overlap..
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13642]: WARNING:core:handle_timer_job: utimer job <tm-utimer> has a 50000 us delay in execution
Feb 18 02:28:58 testfarm /usr/sbin/opensips[13653]: WARNING:core:handle_timer_job: timer job <dlg-timer> has a 50000 us delay in execution
[skip]
Feb 18 02:29:26 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107321890 ms (now 107321990 ms), it may overlap..
Feb 18 02:29:26 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107321990 ms (now 107322090 ms), it may overlap..
Feb 18 02:29:26 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107322090 ms (now 107322190 ms), it may overlap..
Feb 18 02:29:26 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107322190 ms (now 107322290 ms), it may overlap..
Feb 18 02:29:26 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107322290 ms (now 107322390 ms), it may overlap..
Feb 18 02:29:26 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107322390 ms), it may overlap..
Feb 18 02:29:26 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107322390 ms), it may overlap..
Feb 18 02:29:26 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107322390 ms), it may overlap..
Feb 18 02:29:26 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107322390 ms (now 107322490 ms), it may overlap..
Feb 18 02:29:26 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107322490 ms (now 107322590 ms), it may overlap..
Feb 18 02:29:26 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107322590 ms (now 107322690 ms), it may overlap..
Feb 18 02:29:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107322690 ms (now 107322790 ms), it may overlap..
Feb 18 02:29:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107322790 ms (now 107322890 ms), it may overlap..
Feb 18 02:29:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107322890 ms (now 107322990 ms), it may overlap..
Feb 18 02:29:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107322990 ms (now 107323090 ms), it may overlap..
Feb 18 02:29:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107323090 ms (now 107323190 ms), it may overlap..
Feb 18 02:29:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107323190 ms (now 107323290 ms), it may overlap..
Feb 18 02:29:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107323290 ms (now 107323390 ms), it may overlap..
Feb 18 02:29:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107323390 ms), it may overlap..
Feb 18 02:29:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107323390 ms), it may overlap..
Feb 18 02:29:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107323390 ms), it may overlap..
Feb 18 02:29:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107323390 ms (now 107323490 ms), it may overlap..
Feb 18 02:29:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107323490 ms (now 107323590 ms), it may overlap..
Feb 18 02:29:27 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107323590 ms (now 107323690 ms), it may overlap..
Feb 18 02:29:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107323690 ms (now 107323790 ms), it may overlap..
Feb 18 02:29:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107323790 ms (now 107323890 ms), it may overlap..
Feb 18 02:29:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107323890 ms (now 107323990 ms), it may overlap..
Feb 18 02:29:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107323990 ms (now 107324090 ms), it may overlap..
Feb 18 02:29:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107324090 ms (now 107324180 ms), it may overlap..
Feb 18 02:29:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107324180 ms (now 107324280 ms), it may overlap..
Feb 18 02:29:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107324280 ms (now 107324380 ms), it may overlap..
Feb 18 02:29:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107324380 ms), it may overlap..
Feb 18 02:29:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107324380 ms), it may overlap..
Feb 18 02:29:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107324380 ms), it may overlap..
Feb 18 02:29:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107324380 ms (now 107324480 ms), it may overlap..
Feb 18 02:29:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107324480 ms (now 107324580 ms), it may overlap..
Feb 18 02:29:28 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107324580 ms (now 107324680 ms), it may overlap..
Feb 18 02:29:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107324680 ms (now 107324780 ms), it may overlap..
Feb 18 02:29:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107324780 ms (now 107324880 ms), it may overlap..
Feb 18 02:29:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107324880 ms (now 107324980 ms), it may overlap..
Feb 18 02:29:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107324980 ms (now 107325080 ms), it may overlap..
Feb 18 02:29:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107325080 ms (now 107325180 ms), it may overlap..
Feb 18 02:29:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107325180 ms (now 107325280 ms), it may overlap..
Feb 18 02:29:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107325280 ms (now 107325380 ms), it may overlap..
Feb 18 02:29:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107325380 ms), it may overlap..
Feb 18 02:29:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107325380 ms), it may overlap..
Feb 18 02:29:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107325380 ms), it may overlap..
Feb 18 02:29:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107325380 ms (now 107325480 ms), it may overlap..
Feb 18 02:29:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107325480 ms (now 107325580 ms), it may overlap..
Feb 18 02:29:29 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107325580 ms (now 107325680 ms), it may overlap..
Feb 18 02:29:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107325680 ms (now 107325780 ms), it may overlap..
Feb 18 02:29:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107325780 ms (now 107325880 ms), it may overlap..
Feb 18 02:29:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107325880 ms (now 107325980 ms), it may overlap..
Feb 18 02:29:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107325980 ms (now 107326080 ms), it may overlap..
Feb 18 02:29:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107326080 ms (now 107326180 ms), it may overlap..
Feb 18 02:29:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107326180 ms (now 107326280 ms), it may overlap..
Feb 18 02:29:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107326280 ms (now 107326380 ms), it may overlap..
Feb 18 02:29:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107326380 ms), it may overlap..
Feb 18 02:29:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107326380 ms), it may overlap..
Feb 18 02:29:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107326380 ms), it may overlap..
Feb 18 02:29:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107326380 ms (now 107326480 ms), it may overlap..
Feb 18 02:29:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107326480 ms (now 107326580 ms), it may overlap..
Feb 18 02:29:30 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107326580 ms (now 107326680 ms), it may overlap..
Feb 18 02:29:31 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107326680 ms (now 107326780 ms), it may overlap..
Feb 18 02:29:31 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107326780 ms (now 107326880 ms), it may overlap..
Feb 18 02:29:31 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107326880 ms (now 107326980 ms), it may overlap..
Feb 18 02:29:31 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107326980 ms (now 107327080 ms), it may overlap..
Feb 18 02:29:31 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107327080 ms (now 107327180 ms), it may overlap..
Feb 18 02:29:31 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107327180 ms (now 107327280 ms), it may overlap..
Feb 18 02:29:31 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107327280 ms (now 107327380 ms), it may overlap..
Feb 18 02:29:31 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107327380 ms), it may overlap..
Feb 18 02:29:31 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107327380 ms), it may overlap..
Feb 18 02:29:31 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107327380 ms), it may overlap..
Feb 18 02:29:31 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107327380 ms (now 107327480 ms), it may overlap..
Feb 18 02:29:31 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107327480 ms (now 107327580 ms), it may overlap..
Feb 18 02:29:31 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107327580 ms (now 107327670 ms), it may overlap..
Feb 18 02:29:32 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107327670 ms (now 107327770 ms), it may overlap..
Feb 18 02:29:32 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107327770 ms (now 107327870 ms), it may overlap..
Feb 18 02:29:32 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107327870 ms (now 107327970 ms), it may overlap..
Feb 18 02:29:32 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107327970 ms (now 107328070 ms), it may overlap..
Feb 18 02:29:32 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107328070 ms (now 107328170 ms), it may overlap..
Feb 18 02:29:32 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107328170 ms (now 107328270 ms), it may overlap..
Feb 18 02:29:32 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107328270 ms (now 107328370 ms), it may overlap..
Feb 18 02:29:32 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107328370 ms), it may overlap..
Feb 18 02:29:32 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107328370 ms), it may overlap..
Feb 18 02:29:32 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107328370 ms), it may overlap..
Feb 18 02:29:32 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107328370 ms (now 107328470 ms), it may overlap..
Feb 18 02:29:32 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107328470 ms (now 107328570 ms), it may overlap..
Feb 18 02:29:32 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107328570 ms (now 107328670 ms), it may overlap..
Feb 18 02:29:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107328670 ms (now 107328770 ms), it may overlap..
Feb 18 02:29:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107328770 ms (now 107328870 ms), it may overlap..
Feb 18 02:29:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107328870 ms (now 107328970 ms), it may overlap..
Feb 18 02:29:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107328970 ms (now 107329070 ms), it may overlap..
Feb 18 02:29:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107329070 ms (now 107329170 ms), it may overlap..
Feb 18 02:29:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107329170 ms (now 107329270 ms), it may overlap..
Feb 18 02:29:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107329270 ms (now 107329370 ms), it may overlap..
Feb 18 02:29:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107329370 ms), it may overlap..
Feb 18 02:29:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107329370 ms), it may overlap..
Feb 18 02:29:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107329370 ms), it may overlap..
Feb 18 02:29:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107329370 ms (now 107329470 ms), it may overlap..
Feb 18 02:29:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107329470 ms (now 107329570 ms), it may overlap..
Feb 18 02:29:33 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107329570 ms (now 107329670 ms), it may overlap..
Feb 18 02:29:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107329670 ms (now 107329770 ms), it may overlap..
Feb 18 02:29:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107329770 ms (now 107329870 ms), it may overlap..
Feb 18 02:29:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107329870 ms (now 107329970 ms), it may overlap..
Feb 18 02:29:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107329970 ms (now 107330070 ms), it may overlap..
Feb 18 02:29:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107330070 ms (now 107330170 ms), it may overlap..
Feb 18 02:29:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107330170 ms (now 107330270 ms), it may overlap..
Feb 18 02:29:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107330270 ms (now 107330370 ms), it may overlap..
Feb 18 02:29:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107330370 ms), it may overlap..
Feb 18 02:29:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107330370 ms), it may overlap..
Feb 18 02:29:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107330370 ms), it may overlap..
Feb 18 02:29:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107330370 ms (now 107330470 ms), it may overlap..
Feb 18 02:29:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107330470 ms (now 107330570 ms), it may overlap..
Feb 18 02:29:34 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107330570 ms (now 107330670 ms), it may overlap..
Feb 18 02:29:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107330670 ms (now 107330770 ms), it may overlap..
Feb 18 02:29:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107330770 ms (now 107330870 ms), it may overlap..
Feb 18 02:29:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107330870 ms (now 107330970 ms), it may overlap..
Feb 18 02:29:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107330970 ms (now 107331070 ms), it may overlap..
Feb 18 02:29:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107331070 ms (now 107331170 ms), it may overlap..
Feb 18 02:29:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107331170 ms (now 107331270 ms), it may overlap..
Feb 18 02:29:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107331270 ms (now 107331370 ms), it may overlap..
Feb 18 02:29:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107331370 ms), it may overlap..
Feb 18 02:29:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107331370 ms), it may overlap..
Feb 18 02:29:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107331370 ms), it may overlap..
Feb 18 02:29:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107331370 ms (now 107331460 ms), it may overlap..
Feb 18 02:29:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107331470 ms (now 107331560 ms), it may overlap..
Feb 18 02:29:35 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107331560 ms (now 107331660 ms), it may overlap..
Feb 18 02:29:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107331660 ms (now 107331760 ms), it may overlap..
Feb 18 02:29:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107331760 ms (now 107331860 ms), it may overlap..
Feb 18 02:29:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107331860 ms (now 107331960 ms), it may overlap..
Feb 18 02:29:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107331960 ms (now 107332060 ms), it may overlap..
Feb 18 02:29:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107332060 ms (now 107332160 ms), it may overlap..
Feb 18 02:29:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107332160 ms (now 107332260 ms), it may overlap..
Feb 18 02:29:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107332260 ms (now 107332360 ms), it may overlap..
Feb 18 02:29:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107332360 ms), it may overlap..
Feb 18 02:29:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107332360 ms), it may overlap..
Feb 18 02:29:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107332360 ms), it may overlap..
Feb 18 02:29:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107332360 ms (now 107332460 ms), it may overlap..
Feb 18 02:29:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107332460 ms (now 107332560 ms), it may overlap..
Feb 18 02:29:36 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107332560 ms (now 107332660 ms), it may overlap..
Feb 18 02:29:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107332660 ms (now 107332760 ms), it may overlap..
Feb 18 02:29:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107332760 ms (now 107332860 ms), it may overlap..
Feb 18 02:29:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107332860 ms (now 107332960 ms), it may overlap..
Feb 18 02:29:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107332960 ms (now 107333060 ms), it may overlap..
Feb 18 02:29:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107333060 ms (now 107333160 ms), it may overlap..
Feb 18 02:29:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107333160 ms (now 107333260 ms), it may overlap..
Feb 18 02:29:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107333260 ms (now 107333360 ms), it may overlap..
Feb 18 02:29:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107333360 ms), it may overlap..
Feb 18 02:29:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107333360 ms), it may overlap..
Feb 18 02:29:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107333360 ms), it may overlap..
Feb 18 02:29:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107333360 ms (now 107333460 ms), it may overlap..
Feb 18 02:29:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107333460 ms (now 107333560 ms), it may overlap..
Feb 18 02:29:37 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107333560 ms (now 107333660 ms), it may overlap..
Feb 18 02:29:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107333660 ms (now 107333760 ms), it may overlap..
Feb 18 02:29:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107333760 ms (now 107333860 ms), it may overlap..
Feb 18 02:29:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107333860 ms (now 107333960 ms), it may overlap..
Feb 18 02:29:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107333960 ms (now 107334060 ms), it may overlap..
Feb 18 02:29:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107334060 ms (now 107334160 ms), it may overlap..
Feb 18 02:29:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107334160 ms (now 107334260 ms), it may overlap..
Feb 18 02:29:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107334260 ms (now 107334360 ms), it may overlap..
Feb 18 02:29:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107334360 ms), it may overlap..
Feb 18 02:29:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107334360 ms), it may overlap..
Feb 18 02:29:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107334360 ms), it may overlap..
Feb 18 02:29:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107334360 ms (now 107334460 ms), it may overlap..
Feb 18 02:29:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107334460 ms (now 107334560 ms), it may overlap..
Feb 18 02:29:38 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107334560 ms (now 107334660 ms), it may overlap..
Feb 18 02:29:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107334660 ms (now 107334760 ms), it may overlap..
Feb 18 02:29:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107334760 ms (now 107334860 ms), it may overlap..
Feb 18 02:29:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107334860 ms (now 107334960 ms), it may overlap..
Feb 18 02:29:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107334960 ms (now 107335060 ms), it may overlap..
Feb 18 02:29:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107335060 ms (now 107335160 ms), it may overlap..
Feb 18 02:29:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107335160 ms (now 107335250 ms), it may overlap..
Feb 18 02:29:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107335250 ms (now 107335350 ms), it may overlap..
Feb 18 02:29:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107335350 ms), it may overlap..
Feb 18 02:29:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107335350 ms), it may overlap..
Feb 18 02:29:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107335350 ms), it may overlap..
Feb 18 02:29:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107335350 ms (now 107335450 ms), it may overlap..
Feb 18 02:29:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107335450 ms (now 107335550 ms), it may overlap..
Feb 18 02:29:39 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107335550 ms (now 107335650 ms), it may overlap..
Feb 18 02:29:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107335650 ms (now 107335750 ms), it may overlap..
Feb 18 02:29:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107335750 ms (now 107335850 ms), it may overlap..
Feb 18 02:29:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107335850 ms (now 107335950 ms), it may overlap..
Feb 18 02:29:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107335950 ms (now 107336050 ms), it may overlap..
Feb 18 02:29:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107336050 ms (now 107336150 ms), it may overlap..
Feb 18 02:29:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107336150 ms (now 107336250 ms), it may overlap..
Feb 18 02:29:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107336250 ms (now 107336350 ms), it may overlap..
Feb 18 02:29:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107336350 ms), it may overlap..
Feb 18 02:29:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107336350 ms), it may overlap..
Feb 18 02:29:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107336350 ms), it may overlap..
Feb 18 02:29:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107336350 ms (now 107336450 ms), it may overlap..
Feb 18 02:29:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107336450 ms (now 107336550 ms), it may overlap..
Feb 18 02:29:40 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107336550 ms (now 107336650 ms), it may overlap..
Feb 18 02:29:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107336650 ms (now 107336750 ms), it may overlap..
Feb 18 02:29:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107336750 ms (now 107336850 ms), it may overlap..
Feb 18 02:29:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107336850 ms (now 107336950 ms), it may overlap..
Feb 18 02:29:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107336950 ms (now 107337050 ms), it may overlap..
Feb 18 02:29:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107337050 ms (now 107337150 ms), it may overlap..
Feb 18 02:29:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107337150 ms (now 107337250 ms), it may overlap..
Feb 18 02:29:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107337250 ms (now 107337350 ms), it may overlap..
Feb 18 02:29:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107337350 ms), it may overlap..
Feb 18 02:29:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107337350 ms), it may overlap..
Feb 18 02:29:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107337350 ms), it may overlap..
Feb 18 02:29:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107337350 ms (now 107337450 ms), it may overlap..
Feb 18 02:29:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107337450 ms (now 107337550 ms), it may overlap..
Feb 18 02:29:41 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107337550 ms (now 107337650 ms), it may overlap..
Feb 18 02:29:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107337650 ms (now 107337750 ms), it may overlap..
Feb 18 02:29:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107337750 ms (now 107337850 ms), it may overlap..
Feb 18 02:29:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107337850 ms (now 107337950 ms), it may overlap..
Feb 18 02:29:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107337950 ms (now 107338050 ms), it may overlap..
Feb 18 02:29:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107338050 ms (now 107338150 ms), it may overlap..
Feb 18 02:29:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107338150 ms (now 107338250 ms), it may overlap..
Feb 18 02:29:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107338250 ms (now 107338350 ms), it may overlap..
Feb 18 02:29:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107338350 ms), it may overlap..
Feb 18 02:29:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107338350 ms), it may overlap..
Feb 18 02:29:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107338350 ms), it may overlap..
Feb 18 02:29:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107338350 ms (now 107338450 ms), it may overlap..
Feb 18 02:29:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107338450 ms (now 107338550 ms), it may overlap..
Feb 18 02:29:42 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107338550 ms (now 107338640 ms), it may overlap..
Feb 18 02:29:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107338640 ms (now 107338740 ms), it may overlap..
Feb 18 02:29:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107338740 ms (now 107338840 ms), it may overlap..
Feb 18 02:29:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107338840 ms (now 107338940 ms), it may overlap..
Feb 18 02:29:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107338940 ms (now 107339040 ms), it may overlap..
Feb 18 02:29:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107339040 ms (now 107339140 ms), it may overlap..
Feb 18 02:29:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107339140 ms (now 107339240 ms), it may overlap..
Feb 18 02:29:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107339240 ms (now 107339340 ms), it may overlap..
Feb 18 02:29:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107339340 ms), it may overlap..
Feb 18 02:29:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107339340 ms), it may overlap..
Feb 18 02:29:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107339340 ms), it may overlap..
Feb 18 02:29:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107339340 ms (now 107339440 ms), it may overlap..
Feb 18 02:29:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107339440 ms (now 107339540 ms), it may overlap..
Feb 18 02:29:43 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107339540 ms (now 107339640 ms), it may overlap..
Feb 18 02:29:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107339640 ms (now 107339740 ms), it may overlap..
Feb 18 02:29:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107339740 ms (now 107339840 ms), it may overlap..
Feb 18 02:29:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107339840 ms (now 107339940 ms), it may overlap..
Feb 18 02:29:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107339940 ms (now 107340040 ms), it may overlap..
Feb 18 02:29:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107340040 ms (now 107340140 ms), it may overlap..
Feb 18 02:29:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107340140 ms (now 107340240 ms), it may overlap..
Feb 18 02:29:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107340240 ms (now 107340340 ms), it may overlap..
Feb 18 02:29:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-dbupdate> already schedualed for 107250700 ms (now 107340340 ms), it may overlap..
Feb 18 02:29:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-options-pinger> already schedualed for 107310420 ms (now 107340340 ms), it may overlap..
Feb 18 02:29:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <dlg-timer> already schedualed for 107300450 ms (now 107340340 ms), it may overlap..
Feb 18 02:29:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <tm-timer> already schedualed for 107289490 ms (now 107340340 ms), it may overlap..
Feb 18 02:29:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:timer_ticker: timer task <blcore-expire> already schedualed for 107300450 ms (now 107340340 ms), it may overlap..
Feb 18 02:29:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107340340 ms (now 107340440 ms), it may overlap..
Feb 18 02:29:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107340440 ms (now 107340540 ms), it may overlap..
Feb 18 02:29:44 testfarm /usr/sbin/opensips[13559]: WARNING:core:utimer_ticker: utimer task <tm-utimer> already schedualed for 107340540 ms (now 107340640 ms), it may overlap..
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13552]: INFO:core:handle_sigs: child process 13638 exited by a signal 11
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13552]: INFO:core:handle_sigs: core was generated
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13552]: INFO:core:handle_sigs: terminating due to SIGCHLD
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13651]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13649]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13657]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13616]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13654]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13582]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13642]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13630]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13598]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13632]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13555]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13599]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13576]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13595]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13648]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13586]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13589]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13640]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13590]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13559]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13624]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13573]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13562]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13591]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13593]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13621]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13592]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13641]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13574]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13601]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13575]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13584]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13653]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13650]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13585]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13613]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13561]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13610]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13557]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13567]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13556]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13644]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13579]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13578]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13597]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13587]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13604]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13580]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13583]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13652]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13581]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13565]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13570]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13636]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13588]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13607]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13678]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13635]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13627]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13564]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13645]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13572]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13619]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13647]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13646]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13655]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13643]: INFO:core:sig_usr: signal 15 received
Feb 18 02:29:45 testfarm /usr/sbin/opensips[13552]: INFO:core:cleanup: cleanup
Feb 18 02:30:45 testfarm /usr/sbin/opensips[13552]: CRITICAL:core:sig_alarm_abort: BUG - shutdown timeout triggered, dying...
root@testfarm ~ #

trace sig11:

root@testfarm ~ # gdb /usr/sbin/opensips /home/corefiles/core.opensips.sig11.13638
GNU gdb (Debian 7.7.1+dfsg-5) 7.7.1
Copyright (C) 2014 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.  Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
Type "show configuration" for configuration details.
For bug reporting instructions, please see:
<http://www.gnu.org/software/gdb/bugs/>.
Find the GDB manual and other documentation resources online at:
<http://www.gnu.org/software/gdb/documentation/>.
For help, type "help".
Type "apropos word" to search for commands related to "word"...
Reading symbols from /usr/sbin/opensips...Reading symbols from /usr/lib/debug/.build-id/8c/8445b41ab0ad5fa5cd130b42a57498f9aac5f8.debug...done.
done.
[New LWP 13638]
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
Core was generated by `/usr/sbin/opensips -P /run/opensips/opensips.pid -f /etc/opensips/opensips.cfg'.
Program terminated with signal SIGSEGV, Segmentation fault.
#0  internal_search_ID_avp (flags=0, id=125, avp=0x5449564e49000665) at usr_avp.c:318
318                     if ( id==avp->id && (flags==0 || (flags&avp->flags))) {
(gdb) bt full
#0  internal_search_ID_avp (flags=0, id=125, avp=0x5449564e49000665) at usr_avp.c:318
No locals.
#1  search_next_avp (avp=0x7f6f6db378d8, val=0x0) at usr_avp.c:372
No locals.
#2  0x000000000044a485 in next_branches (msg=0x7f6f695cd600 <faked_req>) at serialize.c:399
        val = {n = 1840478456, s = {s = 0x7f6f6db378f8 "h", len = 161}}
        uri = {s = 0x7f6f6db37910 "e\006", len = 134}
        dst_uri = {s = 0x7f6f6db37997 "", len = 0}
        path = {s = 0x7f6f6db37998 "", len = 0}
        path_dst = {s = 0x0, len = -137735424}
        rval = 1224738405
        __FUNCTION__ = "next_branches"
#3  0x0000000000428496 in do_action (a=0x7f6fecd1c718, msg=0x7f6f695cd600 <faked_req>) at action.c:1960
        increment = 125
        decrement = 125
        val_number = 1767691776
        val_s = {s = 0x7f6fecd3bf60 "\006", len = -321669512}
        cdb_reply = 0x7f6fecd3bf60
        aux = {s = 0x7f6fecd3b248 "\r", len = -1}
        key_number = -321667424
        avp_name = {n = -321667040, s = {s = 0x7f6fecd3c020 "\a", len = -321668936}}
        avp_type = 45640
        to = 0x7f6f695cd600 <faked_req>
        new_uri = 0x7f6f695cd600 <faked_req> "\274\241"
        vals = {{s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}}
        result = {s = 0x7f6fecd3bea0 "\001", len = 0}
        uri = {user = {s = 0x0, len = -321667328}, passwd = {s = 0x0, len = 0}, host = {s = 0x0, len = 0}, port = {s = 0x0,
            len = 0}, params = {s = 0x0, len = 0}, headers = {s = 0x0, len = 0}, port_no = 0, proto = 0, type = ERROR_URI_T,
          transport = {s = 0x0, len = 0}, ttl = {s = 0x0, len = 0}, user_param = {s = 0x0, len = 0}, maddr = {
            s = 0x7f6f6d8854d3 "\r\nv=0\r\no=user1 53655765 2353687637 IN IP4 192.168.0.6\r\ns=-\r\nc=IN IP4 192.168.0.6\r\nt=0 0\r\nm=audio 9608 RTP/AVP 0\r\na=rtpmap:0 PCMU/8000\r\n", len = 1837651155}, method = {s = 0x0, len = 0}, lr = {s = 0x0,
            len = 0}, r2 = {s = 0x0, len = 0}, gr = {s = 0x0, len = 0}, transport_val = {s = 0x0, len = 0}, ttl_val = {
---Type <return> to continue, or q <return> to quit---
            s = 0x0, len = 0}, user_param_val = {s = 0x0, len = 1837650680}, maddr_val = {
            s = 0x262 <error: Cannot access memory at address 0x262>, len = 0}, method_val = {s = 0x0, len = 0}, lr_val = {
            s = 0x0, len = 0}, r2_val = {s = 0x0, len = 0}, gr_val = {s = 0x0, len = 0}, u_name = {{s = 0x0, len = 0}, {
              s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0,
              len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}}, u_val = {{s = 0x0, len = 0}, {s = 0x0,
              len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {
              s = 0x0, len = 0}, {
              s = 0x7f6ffcdc932c <re_string_reconstruct+1612> "\351W\372\377\377E1\366\353\267f.\017\037\204", len = 0}, {
              s = 0x0, len = 0}}, u_params_no = 42528}
        next_hop = {user = {s = 0x0, len = 8285618}, passwd = {s = 0x7ffc986fa8b0 "", len = -1737513152}, host = {
            s = 0x22ff3b0 "", len = -52948736}, port = {s = 0x7ffc986fa8b0 "", len = 2}, params = {
            s = 0x3 <error: Cannot access memory at address 0x3>, len = -1737513152}, headers = {s = 0x0, len = -1737513152},
          port_no = 21520, proto = 560, type = ERROR_URI_T, transport = {
            s = 0x7f6ffcdcfc5f <re_search_internal+2975> "\213D$DH\201\304\330\001", len = 0}, ttl = {
            s = 0x88 <error: Cannot access memory at address 0x88>, len = -1737513208}, user_param = {s = 0x0, len = 0},
          maddr = {s = 0x0, len = 1}, method = {s = 0x2334bc0 "\260L3\002", len = 3}, lr = {s = 0x7f6fecd26578 "\300K3\002",
            len = 3}, r2 = {s = 0x1 <error: Cannot access memory at address 0x1>, len = 1}, gr = {s = 0x7ffc986fa710 "",
            len = 36697008}, transport_val = {s = 0x0, len = 8285618}, ttl_val = {
            s = 0x300000001 <error: Cannot access memory at address 0x300000001>, len = 0}, user_param_val = {s = 0x0,
            len = -1737513204}, maddr_val = {s = 0x0, len = 0}, method_val = {s = 0x0, len = 3}, lr_val = {s = 0x0, len = 0},
          r2_val = {s = 0x0, len = 0}, gr_val = {s = 0x0, len = 0}, u_name = {{s = 0x0, len = 0}, {s = 0x0, len = 8285618}, {
              s = 0x2332a40 "", len = 0}, {s = 0x0, len = 0}, {
              s = 0x300000000 <error: Cannot access memory at address 0x300000000>, len = 3}, {
              s = 0x300000003 <error: Cannot access memory at address 0x300000003>, len = 3}, {
              s = 0x600000003 <error: Cannot access memory at address 0x600000003>, len = 0}, {s = 0x2334c68 "",
              len = 16777217}, {s = 0x1 <error: Cannot access memory at address 0x1>, len = 36916160}, {
              s = 0x300000000 <error: Cannot access memory at address 0x300000000>, len = 0}}, u_val = {{s = 0x0, len = 0}, {
              s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x2334bc0 "\260L3\002", len = -321755784}, {
              s = 0x7e6db2 <int2str_buf+18> "300", len = -1737512784}, {s = 0x0, len = 0}, {
              s = 0x7f6ffcdd4fb5 <__regexec+197> "\211\302\203=\026\250-", len = 1}, {s = 0x7ffc986fa8b0 "", len = 0}, {
              s = 0x7f6f695cd600 <faked_req> "\274\241", len = 1}}, u_params_no = 27776}
        u = 0x5449564e49000665
---Type <return> to continue, or q <return> to quit---
        port = 0
        cmatch = -1737511712
        aitem = 0x29
        model = 0x0
        val = {rs = {s = 0x7f6fecd3c020 "\a", len = -321668936}, ri = 0, flags = 0}
        name_s = {s = 0x1 <error: Cannot access memory at address 0x1>, len = -321668680}
        start = {tv_sec = 0, tv_usec = 140118691397280}
        aux_counter = 0
        __FUNCTION__ = "do_action"
#4  0x0000000000430ad0 in run_action_list (a=<optimized out>, msg=0x7f6f695cd600 <faked_req>) at action.c:172
        ret = -1
        t = 0x7f6fecd1c718
#5  0x000000000045ac2c in eval_elem (e=0x7f6fecd1c7f8, msg=0x7f6f695cd600 <faked_req>, val=0x7ffc986face0) at route.c:1628
        uri = {user = {s = 0x0, len = 0}, passwd = {s = 0x0, len = 0}, host = {s = 0x0, len = 0}, port = {s = 0x0, len = 0},
          params = {s = 0x0, len = 0}, headers = {s = 0x0, len = 0}, port_no = 0, proto = 0, type = ERROR_URI_T, transport = {
            s = 0x0, len = -321670392}, ttl = {s = 0x0, len = 0}, user_param = {s = 0x0, len = 0}, maddr = {s = 0x0, len = 0},
          method = {s = 0x0, len = 0}, lr = {s = 0x0, len = 0}, r2 = {s = 0x0, len = 0}, gr = {s = 0x0, len = 0},
          transport_val = {s = 0x0, len = 0}, ttl_val = {s = 0x4b736f <fm_malloc+1071> "H\215C\030H\213|$\bdH3<%(",
            len = 1908778488}, user_param_val = {
            s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = -1737512144},
          maddr_val = {s = 0x7ffc986fabb0 "", len = 1}, method_val = {s = 0x7ffc986fab20 "`(\321\354o\177", len = 8388627},
          lr_val = {s = 0x4c8271 <parse_params+193> "H\205\300I\211\307\017\204\220\v", len = -321671376}, r2_val = {
            s = 0x200000001 <error: Cannot access memory at address 0x200000001>, len = 1869761560}, gr_val = {
            s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = -1737511888}, u_name = {{
              s = 0x7ffc986fabb0 "", len = -321671448}, {s = 0x7f6fecd3b050 "\350\256\323\354o\177", len = 0}, {
              s = 0x8 <error: Cannot access memory at address 0x8>, len = 1740834176}, {
              s = 0x4ec658 <parse_contacts+2520> "\205\300\017\210\374\002", len = 1}, {
              s = 0x7f6f6cf8e220 "\300\345\370lo\177", len = -321836960}, {s = 0x0, len = -321836960}, {s = 0x0, len = 0}, {
              s = 0x0, len = 0}, {s = 0x0, len = 5060}, {s = 0x4b736f <fm_malloc+1071> "H\215C\030H\213|$\bdH3<%(",
              len = 1869762504}}, u_val = {{
              s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = -321680304}, {
              s = 0x12 <error: Cannot access memory at address 0x12>, len = 31}, {
---Type <return> to continue, or q <return> to quit---
              s = 0xa1 <error: Cannot access memory at address 0xa1>, len = 1024}, {s = 0x48d48c <new_avp+556> "C\306D' ",
              len = 1767691776}, {s = 0x7f6f67c30600 <scontacts+128> "\026\242\323\354o\177", len = -321667840}, {
              s = 0x200000078f4a0 <error: Cannot access memory at address 0x200000078f4a0>, len = 8}, {
              s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = 0}, {
              s = 0x8 <error: Cannot access memory at address 0x8>, len = 256}, {s = 0x0, len = 8}, {s = 0x0, len = 9}},
          u_params_no = 54685}
        ival = -321796104
        lval = {rs = {s = 0x7f6fecd3b998 "1290000", len = 7}, ri = 0, flags = 4}
        rval = {rs = {s = 0x0, len = 0}, ri = 0, flags = 0}
        p = 0x0
        __FUNCTION__ = "eval_elem"
#6  0x000000000045a48d in eval_expr (e=0x7f6fecd1c7f8, msg=msg@entry=0x7f6f695cd600 <faked_req>, val=val@entry=0x7ffc986face0)
    at route.c:1973
        rec_lev = 1
        ret = <optimized out>
        __FUNCTION__ = "eval_expr"
#7  0x0000000000427cb4 in do_assign (msg=0x7f6f695cd600 <faked_req>, a=0x7f6fecd1c848) at action.c:242
        ret = -1
        val = {rs = {s = 0x0, len = 0}, ri = 0, flags = 0}
        dspec = 0x7f6fecd1c630
        __FUNCTION__ = "do_assign"
#8  0x0000000000429a7b in do_action (a=0x7f6fecd1c848, msg=0x7f6f695cd600 <faked_req>) at action.c:1977
        increment = 125
        decrement = 125
        val_number = 0
        val_s = {s = 0x0, len = 0}
        cdb_reply = 0x0
        aux = {s = 0x0, len = 0}
        key_number = 0
        avp_name = {n = 8285620, s = {s = 0x7e6db4 <int2str_buf+20> "0", len = -137735424}}
        avp_type = 0
        to = 0x0
---Type <return> to continue, or q <return> to quit---
        new_uri = 0x0
        vals = {{s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = -137735424}, {s = 0x0, len = -1}, {
            s = 0x7f6fecd3a798 "\r\n", len = -321673318}}
        result = {s = 0x0, len = 0}
        uri = {user = {s = 0x0, len = -321664048}, passwd = {
            s = 0xffffffffffffffff <error: Cannot access memory at address 0xffffffffffffffff>, len = 5114365}, host = {
            s = 0x7f6fecd3a798 "\r\n", len = 0}, port = {s = 0x0, len = -137735424}, params = {s = 0x0, len = -321664048},
          headers = {s = 0x7ffc986fb050 "ӡ\323\354o\177", len = -1737510832}, port_no = 37512, proto = 60625, type = 32623,
          transport = {s = 0x7f6f695cd600 <faked_req> "\274\241", len = 0}, ttl = {
            s = 0x49f6fa <pv_get_hdr_prolog+106> "\205\300\272\001", len = 0}, user_param = {s = 0x0, len = 0}, maddr = {
            s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = 0}, method = {
            s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = -321664048}, lr = {
            s = 0x4a3685 <pv_get_hdr+181> "\205\300\211D$\030\017\204", <incomplete sequence \367>, len = 8}, r2 = {s = 0x0,
            len = 0}, gr = {s = 0x0, len = 0}, transport_val = {s = 0x0, len = -321809947}, ttl_val = {
            s = 0x8 <error: Cannot access memory at address 0x8>, len = 0}, user_param_val = {
            s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = -1737509488},
          maddr_val = {s = 0x7f6fecd19270 "\005", len = -321664048}, method_val = {
            s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = 30}, lr_val = {
            s = 0x7f6fecd194f8 "N", len = 1767691776}, r2_val = {
            s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = 31}, gr_val = {
            s = 0x7f6fecd1c128 "\020", len = 1767691776}, u_name = {{s = 0x7f6f695cd600 <faked_req> "\274\241", len = 0}, {
              s = 0x7f6f695cd600 <faked_req> "\274\241", len = 0}, {
              s = 0x430ad0 <run_action_list+64> "\205\300u\a\203\r\005)6", len = 0}, {s = 0x0, len = 1767691776}, {s = 0x0,
              len = -321797624}, {s = 0x45ac2c <eval_elem+1660> "H\205\333t\n\307C\024\030", len = 0}, {
              s = 0xffffffffffffffff <error: Cannot access memory at address 0xffffffffffffffff>, len = 0}, {
              s = 0xa <error: Cannot access memory at address 0xa>, len = -321674797}, {
              s = 0x37 <error: Cannot access memory at address 0x37>, len = 0}, {
              s = 0x7ffc00000001 <error: Cannot access memory at address 0x7ffc00000001>, len = -1737509561}}, u_val = {{
              s = 0x7fffffff <error: Cannot access memory at address 0x7fffffff>, len = 1}, {s = 0x0, len = 0}, {s = 0x0,
              len = 0}, {s = 0x7f6fffffffff <error: Cannot access memory at address 0x7f6fffffffff>, len = 0}, {
              s = 0x7f6ffcd50a7a <_IO_vfprintf_internal+22490> "\200\275(\373\377\377", len = 32}, {s = 0x55fab7 "%-d",
              len = 0}, {s = 0x7f6f00000001 <error: Cannot access memory at address 0x7f6f00000001>, len = 5634746}, {
---Type <return> to continue, or q <return> to quit---
              s = 0x7f6ffcd50a7a <_IO_vfprintf_internal+22490> "\200\275(\373\377\377", len = -53147014}, {s = 0x0, len = 0}, {
              s = 0x0, len = -1}}, u_params_no = 12}
        next_hop = {user = {s = 0x7f6f00000000 <error: Cannot access memory at address 0x7f6f00000000>, len = 40}, passwd = {
            s = 0x7ffc986fb7e0 "\240\364x", len = -1737509088}, host = {
            s = 0xb00000000 <error: Cannot access memory at address 0xb00000000>, len = 13}, port = {s = 0x55dfeb "",
            len = -53147014}, params = {s = 0x7f6ffcd50a7a <_IO_vfprintf_internal+22490> "\200\275(\373\377\377", len = 0},
          headers = {s = 0x0, len = 0}, port_no = 57321, proto = 85, type = ERROR_URI_T, transport = {
            s = 0xc <error: Cannot access memory at address 0xc>, len = 1897081815}, ttl = {
            s = 0x3000000028 <error: Cannot access memory at address 0x3000000028>, len = -1737508784}, user_param = {
            s = 0x7ffc986fb790 "", len = 5627881}, maddr = {
            s = 0xd91c79a60000001a <error: Cannot access memory at address 0xd91c79a60000001a>, len = 5627968}, method = {
            s = 0x55e054 "", len = 1897082013}, lr = {
            s = 0x7f6f0000000a <error: Cannot access memory at address 0x7f6f0000000a>, len = 5627988}, r2 = {
            s = 0x4ddb5a <parse_to+3914> "H\205\300I\211\302D\213\\$\b\017\204\212\006", len = 5627965}, gr = {
            s = 0x7f6f0000001d <error: Cannot access memory at address 0x7f6f0000001d>, len = -321668680}, transport_val = {
            s = 0x3000000028 <error: Cannot access memory at address 0x3000000028>, len = -1737508672}, ttl_val = {
            s = 0x7ffc986fb800 "\300d|", len = 219}, user_param_val = {
            s = 0x3000000018 <error: Cannot access memory at address 0x3000000018>, len = -1737508656}, maddr_val = {
            s = 0x7ffc986fb810 "p\270o\230\374\177", len = 0}, method_val = {s = 0x7ffc986fb590 "\200\267o\230\374\177",
            len = -1737510132}, lr_val = {s = 0x7ffc986fb310 "", len = 48}, r2_val = {
            s = 0x20 <error: Cannot access memory at address 0x20>, len = 72}, gr_val = {s = 0x7f6f71132b88 "`",
            len = 1897081897}, u_name = {{s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>,
              len = 29}, {s = 0x0, len = 0}, {s = 0x4dc9c3 <free_to_params+99> "H\205\333I\211\330u\275H\213D$\030dH3\004%(",
              len = 420}, {s = 0x7f6fecd3caec "", len = 0}, {
              s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = -321679024}, {
              s = 0x4b736f <fm_malloc+1071> "H\215C\030H\213|$\bdH3<%(", len = -321679024}, {
              s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = -321671856}, {
              s = 0x7f6fecd19170 "\270\221\321\354o\177", len = -1737510048}, {s = 0x7f6fecd19188 "h\271\323\354o\177",
              len = 1767691776}, {s = 0x491b4e <set_var_value+78> "\213E\bH\213S\030\211C HcE\b\306\004\002", len = 16}},
          u_val = {{s = 0x2322010 "\217I+:\b\332\"\212=m܆", len = -321810168}, {s = 0x7f6fecd190f0 "N", len = -1737509888}, {
              s = 0x4971e0 <pv_set_scriptvar+96> "1\322H\205\300\017\204\245", len = 36839184}, {
              s = 0x1 <error: Cannot access memory at address 0x1>, len = -321671856}, {
---Type <return> to continue, or q <return> to quit---
              s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = -1737509888}, {
              s = 0x2 <error: Cannot access memory at address 0x2>, len = -321797624}, {
              s = 0x7f6f695cd600 <faked_req> "\274\241", len = 0}, {s = 0x7f6f695cd600 <faked_req> "\274\241", len = 0}, {
              s = 0x45a48d <eval_expr+493> "\213\035m\367\063", len = -321809536}, {s = 0x7f6fecd190f0 "N",
              len = -1737509888}}, u_params_no = 21248}
        u = 0x5449564e49000665
        port = 0
        cmatch = -321810568
        aitem = 0x37
        model = 0x0
        val = {rs = {s = 0x7e6db4 <int2str_buf+20> "0", len = -137735424}, ri = 1, flags = 28}
        name_s = {s = 0x0, len = 0}
        start = {tv_sec = 0, tv_usec = 0}
        aux_counter = 0
        __FUNCTION__ = "do_action"
#9  0x0000000000430ad0 in run_action_list (a=<optimized out>, msg=0x7f6f695cd600 <faked_req>) at action.c:172
        ret = -1
        t = 0x7f6fecd1c848
#10 0x000000000042dc40 in do_action (a=0x7f6fecd1de08, msg=0x7f6f695cd600 <faked_req>) at action.c:1128
        increment = 125
        decrement = 125
        val_number = 0
        val_s = {s = 0x23336d0 "", len = 36881478}
        cdb_reply = 0x23336d0
        aux = {s = 0x0, len = 0}
        key_number = 0
        avp_name = {n = 36912016, s = {s = 0x2333b90 "", len = 36881475}}
        avp_type = 0
        to = 0x0
        new_uri = 0x0
        vals = {{s = 0x2322990 "C", len = 16384}, {s = 0x0, len = -137735424}, {s = 0x2322990 "C", len = 36914672}, {
            s = 0x16 <error: Cannot access memory at address 0x16>, len = -43129200}, {s = 0x0, len = 36841872}}
---Type <return> to continue, or q <return> to quit---
        result = {s = 0x0, len = 0}
        uri = {user = {s = 0x7ffc986fb780 "\240\364x", len = 1821268386}, passwd = {
            s = 0x7b67a6 <sql_buf+742> "0,'2016-02-18 02:28:15')", len = 22}, host = {s = 0x0, len = 36705040}, port = {
            s = 0x0, len = 8087462}, params = {s = 0x7c64bf <sql_buf+65535> "", len = 0}, headers = {s = 0x0, len = 0},
          port_no = 0, proto = 0, type = ERROR_URI_T, transport = {s = 0x0, len = 13}, ttl = {
            s = 0xf0 <error: Cannot access memory at address 0xf0>, len = 3}, user_param = {
            s = 0x7f6f00000033 <error: Cannot access memory at address 0x7f6f00000033>, len = 0}, maddr = {
            s = 0x5b <error: Cannot access memory at address 0x5b>, len = 0}, method = {s = 0x0, len = 110}, lr = {s = 0x0,
            len = 124}, r2 = {s = 0x7ffc986fb690 "\360E3\002", len = 10}, gr = {s = 0x7f6ffd0aa620 <main_arena> "",
            len = 200}, transport_val = {s = 0x23345f0 "\340#2\002", len = 1}, ttl_val = {
            s = 0xb <error: Cannot access memory at address 0xb>, len = 36914672}, user_param_val = {
            s = 0x7f6ffcd81100 <__GI___libc_malloc+96> "H\205\300H\211\302tx\203=\305\346\062", len = -1737509152},
          maddr_val = {s = 0x23345f0 "\340#2\002", len = -1737509152}, method_val = {
            s = 0x7f6f6c8e0fe7 "\205\300u]\017\266U\347\200\372ItD\200\372Tt/\200\372E\017\225\302\017\266҃\302\003\211\223\020\001", len = -1737509049}, lr_val = {s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>,
            len = -1737509049}, r2_val = {s = 0x5a <error: Cannot access memory at address 0x5a>, len = -1737508960},
          gr_val = {s = 0x7f6f6c8e2312 "\205\300\017\205\264\001", len = 11}, u_name = {{
              s = 0x7f6ffcdb08d7 <__tzstring+71> "\205\300tMH\213\023H\205\322u\325H\215}\021\350$;\367\377H\205\300I\211\306tLL\215`\020", <incomplete sequence \307>, len = 49}, {s = 0x330 <error: Cannot access memory at address 0x330>, len = 12}, {
              s = 0x7ffc0000003c <error: Cannot access memory at address 0x7ffc0000003c>, len = 1}, {
              s = 0x7ffc986fb758 "\360E3\002", len = -1737509024}, {s = 0x7ffc986fb75c "", len = -1737509008}, {
              s = 0x7f6f00000001 <error: Cannot access memory at address 0x7f6f00000001>, len = 124}, {
              s = 0x23345f0 "\340#2\002", len = 36902688}, {
              s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = -1737508960}, {
              s = 0x23345f0 "\340#2\002", len = 7926944}, {s = 0x1 <error: Cannot access memory at address 0x1>, len = 0}},
          u_val = {{s = 0x0, len = -1737508864}, {s = 0x7f6f6c8d9c38 <PQgetResult+56> "D\213\243\f\001", len = 0}, {
              s = 0x7b64c0 <sql_buf> "insert into opensips.cdr (method,from_tag,to_tag,i_callid,c_disc_code,c_disc_reason,c_disc_time,c_is_last,o_setup_time,i_alert_time,o_alert_time,c_conn_time,i_src_num,i_dst_num,o_callid,c_route_num,i_"..., len = 0}, {
              s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = -1737508864}, {
              s = 0x7f6fecd2d728 "0\266\222ho\177", len = 7926944}, {s = 0x1 <error: Cannot access memory at address 0x1>,
              len = 0}, {s = 0x0, len = 8152256}, {
              s = 0x7f6f6cafd31b <db_postgres_submit_query+923> "\203\370\a\017\205'\006", len = -1737508752}, {
---Type <return> to continue, or q <return> to quit---
              s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = 0}, {
              s = 0x10b <error: Cannot access memory at address 0x10b>, len = -1737508768}}, u_params_no = 47192}
        next_hop = {user = {
            s = 0x7b669d <sql_buf+477> "'INVITE','4955SIPpTag00885959','rtg4955SIPpTag00885959','885959-4955@192.168.0.5','300','Multiply Choices','2016-02-18 02:28:15','','','','','','97800510009','22#32821032290','','','192.168.0.5','','5"...,
            len = -1737508780}, passwd = {s = 0x100000000 <error: Cannot access memory at address 0x100000000>,
            len = 5214241}, host = {
            s = 0x7f6f6caff530 <db_postgres_val2str> "AWAVAUATI\211\324USH\211\313H\203\354(dH\213\004%(", len = 41}, port = {
            s = 0x29 <error: Cannot access memory at address 0x29>, len = 1754435328}, params = {
            s = 0x7f6f695cd600 <faked_req> "\274\241", len = -321726656}, headers = {s = 0x7ffc986fb978 "P\255\323\354o\177",
            len = 1}, port_no = 62624, proto = 120, type = ERROR_URI_T, transport = {s = 0x0, len = 1754445312}, ttl = {
            s = 0x7f6f6cafc770 <free_query+64> "H\213\003H\307@H", len = -1737508488}, user_param = {
            s = 0x1 <error: Cannot access memory at address 0x1>, len = 1754438016}, maddr = {
            s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = 26}, method = {
            s = 0x7f6fecd2d728 "0\266\222ho\177", len = -1737508488}, lr = {
            s = 0x1 <error: Cannot access memory at address 0x1>, len = 7926944}, r2 = {
            s = 0x7f6f6cafca49 <db_postgres_store_result+505> "H\213L$\030dH3\f%(", len = 1767691776}, gr = {
            s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = -321671856},
          transport_val = {s = 0x0, len = -321671856}, ttl_val = {s = 0x4f6bd4 <db_free_result+116> "1\300H\213T$\bdH3\024%(",
            len = 0}, user_param_val = {s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>,
            len = 1754438016}, maddr_val = {s = 0x7f6fecd2d728 "0\266\222ho\177", len = 0}, method_val = {
            s = 0x7f6f6cafe4ae <db_postgres_insert+94> "H\203{\020", len = 0}, lr_val = {s = 0x7f6fecd3ad50 "\001", len = 0},
          r2_val = {s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = 39}, gr_val = {
            s = 0x7f6f695cd600 <faked_req> "\274\241", len = 1}, u_name = {{s = 0x7f6f68929980 <val_arr> "PNIro\177",
              len = 1754439696}, {s = 0x7f6f686f4913 <acc_db_request+1635> "\205\300\017\211W\375\377\377H\213\005\206\025!",
              len = 1754439960}, {s = 0x0, len = 1754438640}, {
              s = 0x2000000020 <error: Cannot access memory at address 0x2000000020>, len = 0}, {s = 0x0, len = 1455762495}, {
              s = 0x0, len = 0}, {s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>,
              len = 0}, {s = 0x7f6f695cd600 <faked_req> "\274\241", len = 0}, {s = 0x7f6fecd3cbd0 "\273\241",
              len = 1754293236}, {s = 0x7f6f6892b600 <acc_env> ",\001", len = -321672096}}, u_val = {{
              s = 0x7f6f686feae2 <tmcb_func+2850> "A\vm", len = 33}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0,
              len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {
---Type <return> to continue, or q <return> to quit---
              s = 0xd91c79a6f7ca5300 <error: Cannot access memory at address 0xd91c79a6f7ca5300>, len = 0}}, u_params_no = 32}
        u = 0x5449564e49000665
        port = 0
        cmatch = -321810568
        aitem = 0x1
        model = 0x0
        val = {rs = {s = 0x2333b90 "", len = 36881475}, ri = 801, flags = 0}
        name_s = {s = 0x0, len = 0}
        start = {tv_sec = 0, tv_usec = 0}
        aux_counter = 0
        __FUNCTION__ = "do_action"
#11 0x0000000000430ad0 in run_action_list (a=a@entry=0x7f6fecd18f78, msg=msg@entry=0x7f6f695cd600 <faked_req>) at action.c:172
        ret = -1
        t = 0x7f6fecd1de08
#12 0x0000000000430e38 in run_actions (msg=0x7f6f695cd600 <faked_req>, a=0x7f6fecd18f78) at action.c:137
        msg = 0x7f6f695cd600 <faked_req>
        a = 0x7f6fecd18f78
#13 run_top_route (a=0x7f6fecd18f78, msg=0x7f6f695cd600 <faked_req>) at action.c:212
        bl_last_msg_id = 41404
        bk_action_flags = 0
        bk_rec_lev = 0
        ret = <optimized out>
#14 0x00007f6f6938074d in run_failure_handlers (t=<optimized out>) at t_reply.c:581
        shmem_msg = 0x7a5243f0
        faked_req = {id = 41404, first_line = {type = 1, len = 52, u = {request = {method = {
                  s = 0x7f6f72494e50 "INVITE sip:22#32821032290@192.168.0.1:5060 SIP/2.0\r\nVia: SIP/2.0/UDP 192.168.0.5:5060;branch=z9hG4bK885959\r\nFrom: 97800510009 <sip:97800510009@192.168.0.5:5060>;tag=4955SIPpTag00885959\r\nTo: 22#3282103"...,
                  len = 6}, uri = {
                  s = 0x7f6f72494e57 "sip:22#32821032290@192.168.0.1:5060 SIP/2.0\r\nVia: SIP/2.0/UDP 192.168.0.5:5060;branch=z9hG4bK885959\r\nFrom: 97800510009 <sip:97800510009@192.168.0.5:5060>;tag=4955SIPpTag00885959\r\nTo: 22#32821032290 <s"...,
                  len = 35}, version = {
                  s = 0x7f6f72494e7b "SIP/2.0\r\nVia: SIP/2.0/UDP 192.168.0.5:5060;branch=z9hG4bK885959\r\nFrom: 97800510009 <si---Type <return> to continue, or q <return> to quit---
p:97800510009@192.168.0.5:5060>;tag=4955SIPpTag00885959\r\nTo: 22#32821032290 <sip:22#32821032290@192.168.0.1:5060>\r"...,
                  len = 7}, method_value = 1}, reply = {version = {
                  s = 0x7f6f72494e50 "INVITE sip:22#32821032290@192.168.0.1:5060 SIP/2.0\r\nVia: SIP/2.0/UDP 192.168.0.5:5060;branch=z9hG4bK885959\r\nFrom: 97800510009 <sip:97800510009@192.168.0.5:5060>;tag=4955SIPpTag00885959\r\nTo: 22#3282103"...,
                  len = 6}, status = {
                  s = 0x7f6f72494e57 "sip:22#32821032290@192.168.0.1:5060 SIP/2.0\r\nVia: SIP/2.0/UDP 192.168.0.5:5060;branch=z9hG4bK885959\r\nFrom: 97800510009 <sip:97800510009@192.168.0.5:5060>;tag=4955SIPpTag00885959\r\nTo: 22#32821032290 <s"...,
                  len = 35}, reason = {
                  s = 0x7f6f72494e7b "SIP/2.0\r\nVia: SIP/2.0/UDP 192.168.0.5:5060;branch=z9hG4bK885959\r\nFrom: 97800510009 <sip:97800510009@192.168.0.5:5060>;tag=4955SIPpTag00885959\r\nTo: 22#32821032290 <sip:22#32821032290@192.168.0.1:5060>\r"...,
                  len = 7}, statuscode = 1}}}, via1 = 0x7f6f724950d8, via2 = 0x0, headers = 0x7f6f72495090,
          last_header = 0x7f6f72495ab8, parsed_flag = 18446744073709551615, h_via1 = 0x7f6f72495090, h_via2 = 0x0,
          callid = 0x7f6f724958d8, to = 0x7f6f72495588, cseq = 0x7f6f72495920, from = 0x7f6f72495208,
          contact = 0x7f6f72495998, maxforwards = 0x7f6f724959e0, route = 0x0, record_route = 0x0, path = 0x0,
          content_type = 0x7f6f72495a70, content_length = 0x7f6f72495ab8, authorization = 0x0, expires = 0x0,
          proxy_auth = 0x0, supported = 0x0, proxy_require = 0x0, unsupported = 0x0, allow = 0x0, event = 0x0, accept = 0x0,
          accept_language = 0x0, organization = 0x0, priority = 0x0, subject = 0x7f6f72495a28, user_agent = 0x0,
          content_disposition = 0x0, accept_disposition = 0x0, diversion = 0x0, rpid = 0x0, refer_to = 0x0,
          session_expires = 0x0, min_se = 0x0, ppi = 0x0, pai = 0x0, privacy = 0x0, call_info = 0x0, www_authenticate = 0x0,
          proxy_authenticate = 0x0, min_expires = 0x0, sdp = 0x0, multi = 0x0,
          eoh = 0x7f6f72495004 "\r\nv=0\r\no=user1 53655765 2353687637 IN IP4 192.168.0.5\r\ns=-\r\nc=IN IP4 192.168.0.5\r\nt=0 0\r\nm=audio 9832 RTP/AVP 0\r\na=rtpmap:0 PCMU/8000\r\n",
          unparsed = 0x7f6f72495004 "\r\nv=0\r\no=user1 53655765 2353687637 IN IP4 192.168.0.5\r\ns=-\r\nc=IN IP4 192.168.0.5\r\nt=0 0\r\nm=audio 9832 RTP/AVP 0\r\na=rtpmap:0 PCMU/8000\r\n", rcv = {src_ip = {af = 2, len = 4, u = {addrl = {83929280, 0},
                addr32 = {83929280, 0, 0, 0}, addr16 = {43200, 1280, 0, 0, 0, 0, 0, 0},
                addr = "\300\250\000\005", '\000' <repeats 11 times>}}, dst_ip = {af = 2, len = 4, u = {addrl = {16820416, 0},
                addr32 = {16820416, 0, 0, 0}, addr16 = {43200, 256, 0, 0, 0, 0, 0, 0},
                addr = "\300\250\000\001", '\000' <repeats 11 times>}}, src_port = 5060, dst_port = 5060, proto = 1,
            proto_reserved1 = 0, proto_reserved2 = 0, src_su = {s = {sa_family = 2,
                sa_data = "\023\304\300\250\000\005\000\000\000\000\000\000\000"}, sin = {sin_family = 2, sin_port = 50195,
                sin_addr = {s_addr = 83929280}, sin_zero = "\000\000\000\000\000\000\000"}, sin6 = {sin6_family = 2,
                sin6_port = 50195, sin6_flowinfo = 83929280, sin6_addr = {__in6_u = {__u6_addr8 = '\000' <repeats 15 times>,
---Type <return> to continue, or q <return> to quit---
                    __u6_addr16 = {0, 0, 0, 0, 0, 0, 0, 0}, __u6_addr32 = {0, 0, 0, 0}}}, sin6_scope_id = 4641586}},
            bind_address = 0x7f6fecd0cac8},
          buf = 0x7f6f72494e50 "INVITE sip:22#32821032290@192.168.0.1:5060 SIP/2.0\r\nVia: SIP/2.0/UDP 192.168.0.5:5060;branch=z9hG4bK885959\r\nFrom: 97800510009 <sip:97800510009@192.168.0.5:5060>;tag=4955SIPpTag00885959\r\nTo: 22#3282103"..., len = 571,
          new_uri = {
            s = 0x7f6fecd3ada0 "sip:2#32821032290@192.168.0.20;outA=97800510009;outGw=9;vendId=5;ratePlId=62;rateId=21104136;pref=32;rate=700000;routePlId=1;routeId=111=12221", len = 134}, dst_uri = {s = 0x7f6fecd39678 " ", len = 0}, ruri_q = 999,
          ruri_bflags = 0, force_send_socket = 0x0, path_vec = {s = 0x0, len = 0}, parsed_uri_ok = 0, parsed_uri = {user = {
              s = 0x7f6fecd3c85c "", len = 14}, passwd = {s = 0x0, len = 0}, host = {s = 0x7f6fecd3c86b "", len = 9}, port = {
              s = 0x7f6fecd3c875 "", len = 4}, params = {s = 0x0, len = 0}, headers = {s = 0x0, len = 0}, port_no = 6050,
            proto = 0, type = SIP_URI_T, transport = {s = 0x0, len = 0}, ttl = {s = 0x0, len = 0}, user_param = {s = 0x0,
              len = 0}, maddr = {s = 0x0, len = 0}, method = {s = 0x0, len = 0}, lr = {s = 0x0, len = 0}, r2 = {s = 0x0,
              len = 0}, gr = {s = 0x0, len = 0}, transport_val = {s = 0x0, len = 0}, ttl_val = {s = 0x0, len = 0},
            user_param_val = {s = 0x0, len = 0}, maddr_val = {s = 0x0, len = 0}, method_val = {s = 0x0, len = 0}, lr_val = {
              s = 0x0, len = 0}, r2_val = {s = 0x0, len = 0}, gr_val = {s = 0x0, len = 0}, u_name = {{s = 0x0, len = 0}, {
                s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0,
                len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}}, u_val = {{s = 0x0, len = 0}, {s = 0x0,
                len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {
                s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}}, u_params_no = 0}, parsed_orig_ruri_ok = 0,
          parsed_orig_ruri = {user = {s = 0x0, len = 0}, passwd = {s = 0x0, len = 0}, host = {s = 0x0, len = 0}, port = {
              s = 0x0, len = 0}, params = {s = 0x0, len = 0}, headers = {s = 0x0, len = 0}, port_no = 0, proto = 0,
            type = ERROR_URI_T, transport = {s = 0x0, len = 0}, ttl = {s = 0x0, len = 0}, user_param = {s = 0x0, len = 0},
            maddr = {s = 0x0, len = 0}, method = {s = 0x0, len = 0}, lr = {s = 0x0, len = 0}, r2 = {s = 0x0, len = 0}, gr = {
              s = 0x0, len = 0}, transport_val = {s = 0x0, len = 0}, ttl_val = {s = 0x0, len = 0}, user_param_val = {s = 0x0,
              len = 0}, maddr_val = {s = 0x0, len = 0}, method_val = {s = 0x0, len = 0}, lr_val = {s = 0x0, len = 0},
            r2_val = {s = 0x0, len = 0}, gr_val = {s = 0x0, len = 0}, u_name = {{s = 0x0, len = 0}, {s = 0x0, len = 0}, {
                s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0,
                len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}}, u_val = {{s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0,
                len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {s = 0x0, len = 0}, {
                s = 0x0, len = 0}, {s = 0x0, len = 0}}, u_params_no = 0}, add_rm = 0x7f6f6d7599c8, body_lumps = 0x0,
          reply_lump = 0x0, add_to_branch_s = '\000' <repeats 57 times>, add_to_branch_len = 0, hash_index = 62855, flags = 7,
          msg_flags = 163872, set_global_address = {s = 0x0, len = 0}, set_global_port = {s = 0x0, len = 0}, msg_cb = 0x0}
---Type <return> to continue, or q <return> to quit---
#15 t_should_relay_response (Trans=0x7f6f701e96f0, new_code=1, branch=0, should_store=0x7ffc986fbc90,
    should_relay=0x7ffc986fbc8c, cancel_bitmap=0x7f6f6db378c0, reply=0x7a5243f0) at t_reply.c:911
        __FUNCTION__ = "t_should_relay_response"
#16 0x00007f6f693807e8 in relay_reply (t=0x7f6f701e96f0, p_msg=0x7f6fecd3cbd0, branch=0, msg_status=300,
    cancel_bitmap=0x7f6f6cd04190) at t_reply.c:1125
        relay = -652445274
        save_clone = -321675020
        buf = 0x1 <error: Cannot access memory at address 0x1>
        res_len = 0
        relayed_code = 300
        bm = {to_tag_val = {s = 0x70 <error: Cannot access memory at address 0x70>, len = 1}}
        totag_retr = 0
        uas_rb = 0x12c
        cb_s = {s = 0x7f6fecd0cd28 "\t", len = 0}
        text = {s = 0x7f6f71132b88 "`", len = 1765340508}
        __FUNCTION__ = "relay_reply"
#17 0x00007f6f69383e8d in reply_received (p_msg=0x7f6fecd3cbd0) at t_reply.c:1505
        msg_status = 300
        last_uac_status = 0
        branch = 0
        reply_status = <optimized out>
        timer = 140116483635981
        cancel_bitmap = 0
        uac = 0x7f6f701e98c8
        t = 0x7f6f701e96f0
        backup_list = <optimized out>
        has_reply_route = <optimized out>
        __FUNCTION__ = "reply_received"
#18 0x000000000044431c in forward_reply (msg=0x7f6fecd3cbd0) at forward.c:467
        new_buf = 0x0
        to = 0x7c6940 <buf>
        new_len = 0
---Type <return> to continue, or q <return> to quit---
        mod = 0x7f6fecd0d3a8
        proto = 0
        id = 1825587600
        send_sock = 0x0
        len = 1224738405
        __FUNCTION__ = "forward_reply"
#19 0x0000000000433478 in receive_msg (
    buf=0x7c6940 <buf> "SIP/2.0 300 Multiply Choices\r\nVia: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK785f.b7038b4.0\r\nFrom: 97800510009 <sip:97800510009@192.168.0.5:5060>;tag=4955SIPpTag00885959\r\nTo: 22#32821032290 <sip:22#328"..., len=0,
    rcv_info=0x3) at receive.c:243
        ctx = 0x7f6fecd398c0
        msg = 0x7f6fecd3cbd0
        start = {tv_sec = 140118691203784, tv_usec = -2802231110102527232}
        in_buff = {
          s = 0x7f6fecd3a098 "SIP/2.0 300 Multiply Choices\r\nVia: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK785f.b7038b4.0\r\nFrom: 97800510009 <sip:97800510009@192.168.0.5:5060>;tag=4955SIPpTag00885959\r\nTo: 22#32821032290 <sip:22#328"..., len = 1794}
        __FUNCTION__ = "receive_msg"
#20 0x000000000051e9a3 in udp_read_req (si=<optimized out>, bytes_read=<optimized out>) at net/proto_udp/proto_udp.c:190
        ri = {src_ip = {af = 2, len = 4, u = {addrl = {16777343, 0}, addr32 = {16777343, 0, 0, 0}, addr16 = {127, 256, 0, 0,
                0, 0, 0, 0}, addr = "\177\000\000\001", '\000' <repeats 11 times>}}, dst_ip = {af = 2, len = 4, u = {addrl = {
                16777343, 0}, addr32 = {16777343, 0, 0, 0}, addr16 = {127, 256, 0, 0, 0, 0, 0, 0},
              addr = "\177\000\000\001", '\000' <repeats 11 times>}}, src_port = 6050, dst_port = 5060, proto = 1,
          proto_reserved1 = 0, proto_reserved2 = 0, src_su = {s = {sa_family = 2,
              sa_data = "\027\242\177\000\000\001\000\000\000\000\000\000\000"}, sin = {sin_family = 2, sin_port = 41495,
              sin_addr = {s_addr = 16777343}, sin_zero = "\000\000\000\000\000\000\000"}, sin6 = {sin6_family = 2,
              sin6_port = 41495, sin6_flowinfo = 16777343, sin6_addr = {__in6_u = {__u6_addr8 = '\000' <repeats 15 times>,
                  __u6_addr16 = {0, 0, 0, 0, 0, 0, 0, 0}, __u6_addr32 = {0, 0, 0, 0}}}, sin6_scope_id = 4641436}},
          bind_address = 0x7f6fecd0cd28}
        len = <optimized out>
        buf = "SIP/2.0 300 Multiply Choices\r\nVia: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK785f.b7038b4.0\r\nFrom: 97800510009 <sip:97800510009@192.168.0.5:5060>;tag=4955SIPpTag00885959\r\nTo: 22#32821032290 <sip:22#328"...
        fromlen = 16
---Type <return> to continue, or q <return> to quit---
        p = <optimized out>
        msg = {
          s = 0x7c6940 <buf> "SIP/2.0 300 Multiply Choices\r\nVia: SIP/2.0/UDP 127.0.0.1:5060;branch=z9hG4bK785f.b7038b4.0\r\nFrom: 97800510009 <sip:97800510009@192.168.0.5:5060>;tag=4955SIPpTag00885959\r\nTo: 22#32821032290 <sip:22#328"..., len = 1809}
        __FUNCTION__ = "udp_read_req"
#21 0x000000000050d207 in handle_io (fm=<optimized out>, fm=<optimized out>, fm=<optimized out>, idx=<optimized out>,
    event_type=<optimized out>) at net/net_udp.c:259
        read = 1
#22 io_wait_loop_epoll (h=<optimized out>, t=<optimized out>, repeat=<optimized out>) at net/../io_wait_loop.h:215
        e = 0x7d
        r = 0
#23 udp_rcv_loop (si=0x1) at net/net_udp.c:308
        __FUNCTION__ = "udp_rcv_loop"
#24 0x000000000050d708 in udp_start_processes (chd_rank=chd_rank@entry=0x7b35fc <chd_rank>,
    startup_done=startup_done@entry=0x0) at net/net_udp.c:372
        si = 0x7f6fecd0cd28
        load_p = 0x7f6f6cfb5c28
        pid = <optimized out>
        i = 13
        __FUNCTION__ = "udp_start_processes"
#25 0x000000000041a61c in main_loop () at main.c:662
        startup_done = 0x0
        chd_rank = 46
#26 main (argc=<optimized out>, argv=<optimized out>) at main.c:1238
        cfg_stream = <optimized out>
        c = <optimized out>
        r = <optimized out>
        tmp = 0x7ffc986fdee8 ""
        tmp_len = <optimized out>
        port = <optimized out>
        proto = <optimized out>
        options = 0x547ad0 "f:cCm:M:b:l:n:N:rRvdDFETSVhw:t:u:g:P:G:W:o:"
---Type <return> to continue, or q <return> to quit---
        ret = -1
        seed = 3841138250
        __FUNCTION__ = "main"
(gdb)

trace sig6:

root@testfarm ~ # gdb /usr/sbin/opensips /home/corefiles/core.opensips.sig6.13552
GNU gdb (Debian 7.7.1+dfsg-5) 7.7.1
Copyright (C) 2014 Free Software Foundation, Inc.
License GPLv3+: GNU GPL version 3 or later <http://gnu.org/licenses/gpl.html>
This is free software: you are free to change and redistribute it.
There is NO WARRANTY, to the extent permitted by law.  Type "show copying"
and "show warranty" for details.
This GDB was configured as "x86_64-linux-gnu".
Type "show configuration" for configuration details.
For bug reporting instructions, please see:
<http://www.gnu.org/software/gdb/bugs/>.
Find the GDB manual and other documentation resources online at:
<http://www.gnu.org/software/gdb/documentation/>.
For help, type "help".
Type "apropos word" to search for commands related to "word"...
Reading symbols from /usr/sbin/opensips...Reading symbols from /usr/lib/debug/.build-id/8c/8445b41ab0ad5fa5cd130b42a57498f9aac5f8.debug...done.
done.
[New LWP 13552]
[Thread debugging using libthread_db enabled]
Using host libthread_db library "/lib/x86_64-linux-gnu/libthread_db.so.1".
Core was generated by `/usr/sbin/opensips -P /run/opensips/opensips.pid -f /etc/opensips/opensips.cfg'.
Program terminated with signal SIGABRT, Aborted.
#0  0x00007f6ffcd3a147 in __GI_raise (sig=sig@entry=6) at ../nptl/sysdeps/unix/sysv/linux/raise.c:56
56      ../nptl/sysdeps/unix/sysv/linux/raise.c: No such file or directory.
(gdb) bt full
#0  0x00007f6ffcd3a147 in __GI_raise (sig=sig@entry=6) at ../nptl/sysdeps/unix/sysv/linux/raise.c:56
        resultvar = 0
        pid = 13552
        selftid = 13552
#1  0x00007f6ffcd3b528 in __GI_abort () at abort.c:89
        save_stage = 2
        act = {__sigaction_handler = {sa_handler = 0x78f4a0 <log_level>, sa_sigaction = 0x78f4a0 <log_level>}, sa_mask = {
            __val = {1, 1, 140118967815623, 1, 0, 140116533271040, 140118959635752, 0, 1, 140116546490288, 140118967841509, 1,
              140118960564621, 0, 0, 140118963430944}}, sa_flags = 0, sa_restorer = 0x0}
        sigs = {__val = {32, 0 <repeats 15 times>}}
#2  0x000000000048fadd in sig_alarm_abort (signo=<optimized out>) at main.c:403
        __FUNCTION__ = "sig_alarm_abort"
#3  <signal handler called>
No locals.
#4  0x00007f6ffcdd6d27 in sched_yield () at ../sysdeps/unix/syscall-template.S:81
No locals.
#5  0x00007f6f680b6865 in get_lock (lock=<optimized out>) at ../../evi/../fastlock.h:204
        i = 0
#6  dialog_update_db (ticks=0, param=0x7f6f6cf9bc90, param@entry=0x0) at dlg_db_handler.c:1308
        my_ps_update = 0x0
        my_ps_insert = 0x0
        my_ps_update_vp = 0x0
        values = {{type = DB_BIGINT, nul = 0, free = -1737507089, val = {int_val = 1811239837, bigint_val = 6792154534813,
              double_val = 3.3557702168959363e-311, time_val = 6792154534813,
              string_val = 0x62d6bf5539d <error: Cannot access memory at address 0x62d6bf5539d>, str_val = {
                s = 0x62d6bf5539d <error: Cannot access memory at address 0x62d6bf5539d>, len = -1737507504}, blob_val = {
                s = 0x62d6bf5539d <error: Cannot access memory at address 0x62d6bf5539d>, len = -1737507504},
              bitmap_val = 1811239837}}, {type = DB_STR, nul = 0, free = -1737507514, val = {int_val = 1858776320,
              bigint_val = 140116576873728, double_val = 6.9226787046183094e-310, time_val = 140116576873728,
              string_val = 0x7f6f6ecaad00 "885989-4967@192.168.0.4sip:17589598950@192.168.0.4:5060sip:22#52202930237@192.168.0.1:5060-info: 12,6,67,2,96618960694,15223924061\r\nContent-Length: 0\r\n\r\n", str_val = {
                s = 0x7f6f6ecaad00 "885989-4967@192.168.0.4sip:17589598950@192.168.0.4:5060sip:22#52202930237@192.168.0.1:5060-i---Type <return> to continue, or q <return> to quit---
nfo: 12,6,67,2,96618960694,15223924061\r\nContent-Length: 0\r\n\r\n", len = 23}, blob_val = {
                s = 0x7f6f6ecaad00 "885989-4967@192.168.0.4sip:17589598950@192.168.0.4:5060sip:22#52202930237@192.168.0.1:5060-info: 12,6,67,2,96618960694,15223924061\r\nContent-Length: 0\r\n\r\n", len = 23}, bitmap_val = 1858776320}}, {type = DB_STR,
            nul = 0, free = 0, val = {int_val = 1858776343, bigint_val = 140116576873751,
              double_val = 6.9226787046194457e-310, time_val = 140116576873751,
              string_val = 0x7f6f6ecaad17 "sip:17589598950@192.168.0.4:5060sip:22#52202930237@192.168.0.1:5060-info: 12,6,67,2,96618960694,15223924061\r\nContent-Length: 0\r\n\r\n", str_val = {
                s = 0x7f6f6ecaad17 "sip:17589598950@192.168.0.4:5060sip:22#52202930237@192.168.0.1:5060-info: 12,6,67,2,96618960694,15223924061\r\nContent-Length: 0\r\n\r\n", len = 32}, blob_val = {
                s = 0x7f6f6ecaad17 "sip:17589598950@192.168.0.4:5060sip:22#52202930237@192.168.0.1:5060-info: 12,6,67,2,96618960694,15223924061\r\nContent-Length: 0\r\n\r\n", len = 32}, bitmap_val = 1858776343}}, {type = DB_STR, nul = 0, free = 0, val = {
              int_val = 1895577624, bigint_val = 140116613675032, double_val = 6.9226805228443123e-310,
              time_val = 140116613675032, string_val = 0x7f6f70fc3818 "4967SIPpTag00885989\r1", str_val = {
                s = 0x7f6f70fc3818 "4967SIPpTag00885989\r1", len = 19}, blob_val = {
                s = 0x7f6f70fc3818 "4967SIPpTag00885989\r1", len = 19}, bitmap_val = 1895577624}}, {type = DB_STR, nul = 0,
            free = 402653184, val = {int_val = 1858776375, bigint_val = 140116576873783, double_val = 6.9226787046210268e-310,
              time_val = 140116576873783,
              string_val = 0x7f6f6ecaad37 "sip:22#52202930237@192.168.0.1:5060-info: 12,6,67,2,96618960694,15223924061\r\nContent-Length: 0\r\n\r\n", str_val = {
                s = 0x7f6f6ecaad37 "sip:22#52202930237@192.168.0.1:5060-info: 12,6,67,2,96618960694,15223924061\r\nContent-Length: 0\r\n\r\n", len = 35}, blob_val = {
                s = 0x7f6f6ecaad37 "sip:22#52202930237@192.168.0.1:5060-info: 12,6,67,2,96618960694,15223924061\r\nContent-Length: 0\r\n\r\n", len = 35}, bitmap_val = 1858776375}}, {type = DB_STR, nul = 0, free = -51992359, val = {int_val = 1864919672,
              bigint_val = 140116583017080, double_val = 6.9226790081402267e-310, time_val = 140116583017080,
              string_val = 0x7f6f6f286a78 "17996SIPpTag013905935", str_val = {s = 0x7f6f6f286a78 "17996SIPpTag013905935",
                len = 21}, blob_val = {s = 0x7f6f6f286a78 "17996SIPpTag013905935", len = 21}, bitmap_val = 1864919672}}, {
            type = DB_STR, nul = 0, free = -52000590, val = {int_val = -321751672, bigint_val = 140118691313032,
              double_val = 6.9227831718003417e-310, time_val = 140118691313032,
              string_val = 0x7f6fecd27588 "udp:192.168.0.1:5060", str_val = {s = 0x7f6fecd27588 "udp:192.168.0.1:5060",
                len = 20}, blob_val = {s = 0x7f6fecd27588 "udp:192.168.0.1:5060", len = 20}, bitmap_val = 3973215624}}, {
            type = DB_STR, nul = 0, free = 8187, val = {int_val = -321751672, bigint_val = 140118691313032,
              double_val = 6.9227831718003417e-310, time_val = 140118691313032,
---Type <return> to continue, or q <return> to quit---
              string_val = 0x7f6fecd27588 "udp:192.168.0.1:5060", str_val = {s = 0x7f6fecd27588 "udp:192.168.0.1:5060",
                len = 20}, blob_val = {s = 0x7f6fecd27588 "udp:192.168.0.1:5060", len = 20}, bitmap_val = 3973215624}}, {
            type = DB_INT, nul = 0, free = 36724160, val = {int_val = 1455762538, bigint_val = 1455762538,
              double_val = 7.1924225852846221e-315, time_val = 1455762538,
              string_val = 0x56c52c6a <error: Cannot access memory at address 0x56c52c6a>, str_val = {
                s = 0x56c52c6a <error: Cannot access memory at address 0x56c52c6a>, len = -49633760}, blob_val = {
                s = 0x56c52c6a <error: Cannot access memory at address 0x56c52c6a>, len = -49633760},
              bitmap_val = 1455762538}}, {type = DB_STR, nul = 1, free = 76, val = {int_val = 0, bigint_val = 0,
              double_val = 0, time_val = 0, string_val = 0x0, str_val = {s = 0x0, len = 0}, blob_val = {s = 0x0, len = 0},
              bitmap_val = 0}}, {type = DB_STR, nul = 1, free = -1737507264, val = {int_val = 0, bigint_val = 0,
              double_val = 0, time_val = 0, string_val = 0x0, str_val = {s = 0x0, len = 0}, blob_val = {s = 0x0, len = 0},
              bitmap_val = 0}}, {type = DB_STR, nul = 0, free = 96, val = {int_val = 1832120840, bigint_val = 140116550218248,
              double_val = 6.9226773876626153e-310, time_val = 140116550218248,
              string_val = 0x7f6f6d33f208 "sip:17589598950@192.168.0.4:5060\b", str_val = {
                s = 0x7f6f6d33f208 "sip:17589598950@192.168.0.4:5060\b", len = 32}, blob_val = {
                s = 0x7f6f6d33f208 "sip:17589598950@192.168.0.4:5060\b", len = 32}, bitmap_val = 1832120840}}, {type = DB_STR,
            nul = 0, free = 0, val = {int_val = 1833120520, bigint_val = 140116551217928,
              double_val = 6.9226774370533697e-310, time_val = 140116551217928,
              string_val = 0x7f6f6d433308 "sip:192.168.0.20:5060;transport=UDPmo\177", str_val = {
                s = 0x7f6f6d433308 "sip:192.168.0.20:5060;transport=UDPmo\177", len = 35}, blob_val = {
                s = 0x7f6f6d433308 "sip:192.168.0.20:5060;transport=UDPmo\177", len = 35}, bitmap_val = 1833120520}}, {
            type = DB_STR, nul = 0, free = 5541072, val = {int_val = 1837113536, bigint_val = 140116555210944,
              double_val = 6.9226776343345726e-310, time_val = 140116555210944,
              string_val = 0x7f6f6d8020c0 "sip:17589598950@192.168.0.1;user=phone", str_val = {
                s = 0x7f6f6d8020c0 "sip:17589598950@192.168.0.1;user=phone", len = 38}, blob_val = {
                s = 0x7f6f6d8020c0 "sip:17589598950@192.168.0.1;user=phone", len = 38}, bitmap_val = 1837113536}}, {
            type = DB_STR, nul = 0, free = 5541072, val = {int_val = 1828813280, bigint_val = 140116546910688,
              double_val = 6.9226772242474385e-310, time_val = 140116546910688,
              string_val = 0x7f6f6d0179e0 "sip:2#52202930237@192.168.0.20:5060;user=phone", str_val = {
                s = 0x7f6f6d0179e0 "sip:2#52202930237@192.168.0.20:5060;user=phone", len = 46}, blob_val = {
                s = 0x7f6f6d0179e0 "sip:2#52202930237@192.168.0.20:5060;user=phone", len = 46}, bitmap_val = 1828813280}}, {
            type = DB_INT, nul = 0, free = 5541072, val = {int_val = 1, bigint_val = 140720308486145,
---Type <return> to continue, or q <return> to quit---
              double_val = 6.9525070095186676e-310, time_val = 140720308486145,
              string_val = 0x7ffc00000001 <error: Cannot access memory at address 0x7ffc00000001>, str_val = {
                s = 0x7ffc00000001 <error: Cannot access memory at address 0x7ffc00000001>, len = 10}, blob_val = {
                s = 0x7ffc00000001 <error: Cannot access memory at address 0x7ffc00000001>, len = 10}, bitmap_val = 1}}, {
            type = DB_INT, nul = 0, free = -52522017, val = {int_val = 1455655252, bigint_val = 1455655252,
              double_val = 7.1918925220158249e-315, time_val = 1455655252,
              string_val = 0x56c38954 <error: Cannot access memory at address 0x56c38954>, str_val = {
                s = 0x56c38954 <error: Cannot access memory at address 0x56c38954>, len = 1455762585}, blob_val = {
                s = 0x56c38954 <error: Cannot access memory at address 0x56c38954>, len = 1455762585},
              bitmap_val = 1455655252}}, {type = DB_STR, nul = 0, free = 75, val = {int_val = 1835956248,
              bigint_val = 140116554053656, double_val = 6.9226775771569483e-310, time_val = 140116554053656,
              string_val = 0x7f6f6d6e7818 "0", str_val = {s = 0x7f6f6d6e7818 "0", len = 1}, blob_val = {
                s = 0x7f6f6d6e7818 "0", len = 1}, bitmap_val = 1835956248}}, {type = DB_STR, nul = 1, free = 0, val = {
              int_val = 0, bigint_val = 0, double_val = 0, time_val = 0, string_val = 0x0, str_val = {s = 0x0, len = 0},
              blob_val = {s = 0x0, len = 0}, bitmap_val = 0}}, {type = DB_INT, nul = 0, free = 0, val = {int_val = 0,
              bigint_val = 124554051584, double_val = 6.1537877937992897e-313, time_val = 124554051584,
              string_val = 0x1d00000000 <error: Cannot access memory at address 0x1d00000000>, str_val = {
                s = 0x1d00000000 <error: Cannot access memory at address 0x1d00000000>, len = 2}, blob_val = {
                s = 0x1d00000000 <error: Cannot access memory at address 0x1d00000000>, len = 2}, bitmap_val = 0}}, {
            type = DB_INT, nul = 0, free = 4, val = {int_val = 0, bigint_val = 0, double_val = 0, time_val = 0,
              string_val = 0x0, str_val = {s = 0x0, len = 1740906848}, blob_val = {s = 0x0, len = 1740906848},
              bitmap_val = 0}}, {type = DB_BLOB, nul = 0, free = 1828396864, val = {int_val = -321732952,
              bigint_val = 140118691331752, double_val = 6.9227831727252326e-310, time_val = 140118691331752,
              string_val = 0x7f6fecd2bea8 "accX_created#g,\305V", str_val = {s = 0x7f6fecd2bea8 "accX_created#g,\305V",
                len = 22}, blob_val = {s = 0x7f6fecd2bea8 "accX_created#g,\305V", len = 22}, bitmap_val = 3973234344}}, {
            type = DB_STR, nul = 1, free = 1, val = {int_val = 1, bigint_val = 1, double_val = 4.9406564584124654e-324,
              time_val = 1, string_val = 0x1 <error: Cannot access memory at address 0x1>, str_val = {
                s = 0x1 <error: Cannot access memory at address 0x1>, len = 1828396864}, blob_val = {
                s = 0x1 <error: Cannot access memory at address 0x1>, len = 1828396864}, bitmap_val = 1}}, {type = DB_INT,
            nul = 0, free = 1740907472, val = {int_val = 0, bigint_val = 0, double_val = 0, time_val = 0, string_val = 0x0,
              str_val = {s = 0x0, len = 8085024}, blob_val = {s = 0x0, len = 8085024}, bitmap_val = 0}}, {type = DB_INT,
            nul = 0, free = 1, val = {int_val = 10, bigint_val = 140114718097418, double_val = 6.9225868688665019e-310,
---Type <return> to continue, or q <return> to quit---
              time_val = 140114718097418, string_val = 0x7f6f0000000a <error: Cannot access memory at address 0x7f6f0000000a>,
              str_val = {s = 0x7f6f0000000a <error: Cannot access memory at address 0x7f6f0000000a>, len = 1743107344},
              blob_val = {s = 0x7f6f0000000a <error: Cannot access memory at address 0x7f6f0000000a>, len = 1743107344},
              bitmap_val = 10}}, {type = DB_INT, nul = 0, free = 1740908718, val = {int_val = 272, bigint_val = 272,
              double_val = 1.3438585566881906e-321, time_val = 272,
              string_val = 0x110 <error: Cannot access memory at address 0x110>, str_val = {
                s = 0x110 <error: Cannot access memory at address 0x110>, len = -1737507072}, blob_val = {
                s = 0x110 <error: Cannot access memory at address 0x110>, len = -1737507072}, bitmap_val = 272}}}
        callee_leg = 1
        ins_done = 7926944
        ins_list = 0x0
        insert_keys = {0x7f6f682d5e40 <dlg_id_column>, 0x7f6f682d5e30 <call_id_column>, 0x7f6f682d5e20 <from_uri_column>,
          0x7f6f682d5e10 <from_tag_column>, 0x7f6f682d5e00 <to_uri_column>, 0x7f6f682d5df0 <to_tag_column>,
          0x7f6f682d5d20 <from_sock_column>, 0x7f6f682d5d30 <to_sock_column>, 0x7f6f682d5dd0 <start_time_column>,
          0x7f6f682d5d60 <from_route_column>, 0x7f6f682d5d70 <to_route_column>, 0x7f6f682d5d40 <from_contact_column>,
          0x7f6f682d5d50 <to_contact_column>, 0x7f6f682d5d10 <mangled_fu_column>, 0x7f6f682d5d00 <mangled_tu_column>,
          0x7f6f682d5de0 <state_column>, 0x7f6f682d5dc0 <timeout_column>, 0x7f6f682d5da0 <from_cseq_column>,
          0x7f6f682d5db0 <to_cseq_column>, 0x7f6f682d5d80 <from_ping_cseq_column>, 0x7f6f682d5d90 <to_ping_cseq_column>,
          0x7f6f682d5cf0 <vars_column>, 0x7f6f682d5ce0 <profiles_column>, 0x7f6f682d5cd0 <sflags_column>,
          0x7f6f682d5cc0 <mflags_column>, 0x7f6f682d5cb0 <flags_column>}
        __FUNCTION__ = "dialog_update_db"
#7  0x00007f6f680a8587 in mod_destroy () at dialog.c:1005
No locals.
#8  0x0000000000494859 in destroy_modules () at sr_module.c:527
        t = 0x7f6fecd11200
        foo = 0x7f6fecd11028
        __FUNCTION__ = "destroy_modules"
#9  0x0000000000490211 in cleanup (show_status=show_status@entry=1) at main.c:309
        __FUNCTION__ = "cleanup"
#10 0x0000000000490d02 in handle_sigs () at main.c:511
        chld = <optimized out>
        chld_status = 139
---Type <return> to continue, or q <return> to quit---
        overall_status = 139
        i = <optimized out>
        do_exit = 1
        __FUNCTION__ = "handle_sigs"
#11 0x000000000041a78e in main_loop () at main.c:695
        startup_done = <optimized out>
        chd_rank = 64
#12 main (argc=<optimized out>, argv=<optimized out>) at main.c:1238
        cfg_stream = <optimized out>
        c = <optimized out>
        r = <optimized out>
        tmp = 0x7ffc986fdee8 ""
        tmp_len = <optimized out>
        port = <optimized out>
        proto = <optimized out>
        options = 0x547ad0 "f:cCm:M:b:l:n:N:rRvdDFETSVhw:t:u:g:P:G:W:o:"
        ret = -1
        seed = 3841138250
        __FUNCTION__ = "main"
(gdb)

@liviuchircu
Copy link
Member

@ankogan , several fixes regarding serial forking have been pushed to all 2.x branches between February - March.

I strongly recommend updating to the latest version, ideally the latest 2.2 git branch - the above issues may have been already taken care of!

@liviuchircu liviuchircu added this to the 2.2.1 milestone Apr 7, 2016
@bogdan-iancu
Copy link
Member

bogdan-iancu commented May 19, 2016 •
edited
Loading

Most likely to be fixed via 047b1b3 (or d94885a for 2.1), see #855 . I will close this for now, if it happens again, please reopen (but do not forget to update from GIT first ;) )

@ankogan
Copy link
Author

ankogan commented May 19, 2016

Thank you!

2016-05-19 19:03 GMT+03:00 Bogdan Andrei IANCU notifications@github.com:

Most likely to be fixed via 047b1b3
047b1b3
(or d94885a
d94885a
for 1.11), see #855 #855 . I
will close this for now, if it happens again, please reopen (but do not
forget to update from GIT first ;) )

—
You are receiving this because you were mentioned.
Reply to this email directly or view it on GitHub
#782 (comment)

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@liviuchircu liviuchircu

Labels
bug
Projects
None yet
Milestone
2.2.8
Development

No branches or pull requests
3 participants
@bogdan-iancu @liviuchircu @ankogan