Re: [SR-Users] Kamailio stability/timing problem w.r.t. registrations?

Daniel, message for any function to see if flavour modules Thanks for the help! We switched to kamailio flavour, added some xlog messages and managed to reproduce. See below for some logging. To our surprise, the last message handled was an INVITE. We'll add more logging to see whether it is handled successfully or gets stuck somewhere. Those numbers at the start of the log message, are these child IDs? At first they alternate, but apparently child 1 and 2 stop running early on (each with an INVITE as last message). Regards, Michiel Veldkamp 0(304) WARNING: <core> [socket_info.c:1392]: WARNING: fix_hostname: could not rev. resolve 192.168.10.1 0(304) INFO: <core> [tcp_main.c:4832]: init_tcp: using epoll_lt as the io watch method (auto detected) 0(306) INFO: usrloc [hslot.c:53]: locks array size 512 0(306) INFO: <core> [udp_server.c:179]: INFO: udp_init: SO_RCVBUF is initially 108544 0(306) INFO: <core> [udp_server.c:230]: INFO: udp_init: SO_RCVBUF is finally 217088 7(315) INFO: ctl [io_listener.c:225]: io_listen_loop: using epoll_lt io watch method (config) 1(309) ERROR: <script>: request_route start -- method=REGISTER 2(310) ERROR: <script>: request_route start -- method=REGISTER 3(311) ERROR: <script>: request_route start -- method=REGISTER 3(311) ERROR: <script>: route[REGISTRAR] start 2(310) ERROR: <script>: route[REGISTRAR] start 3(311) ERROR: <script>: route[REGISTRAR] saving location... 2(310) ERROR: <script>: route[REGISTRAR] saving location... 1(309) ERROR: <script>: route[REGISTRAR] start 1(309) ERROR: <script>: route[REGISTRAR] saving location... 1(309) ERROR: <script>: route[REGISTRAR] saving location... done 3(311) ERROR: <script>: route[REGISTRAR] saving location... done 2(310) ERROR: <script>: route[REGISTRAR] saving location... done 3(311) ERROR: <script>: request_route start -- method=REGISTER 3(311) ERROR: <script>: route[REGISTRAR] start 3(311) ERROR: <script>: route[REGISTRAR] saving location... 3(311) ERROR: <script>: route[REGISTRAR] saving location... done 2(310) ERROR: <script>: request_route start -- method=REGISTER 1(309) ERROR: <script>: request_route start -- method=REGISTER 1(309) ERROR: <script>: route[REGISTRAR] start 1(309) ERROR: <script>: route[REGISTRAR] saving location... 2(310) ERROR: <script>: route[REGISTRAR] start 2(310) ERROR: <script>: route[REGISTRAR] saving location... 1(309) ERROR: <script>: route[REGISTRAR] saving location... done 2(310) ERROR: <script>: route[REGISTRAR] saving location... done 3(311) ERROR: <script>: request_route start -- method=INVITE 3(311) ERROR: <script>: route[REGISTRAR] start 1(309) ERROR: <script>: request_route start -- method=INVITE 1(309) ERROR: <script>: route[REGISTRAR] start 2(310) ERROR: <script>: request_route start -- method=INVITE 2(310) ERROR: <script>: route[REGISTRAR] start 1(309) ERROR: <script>: request_route start -- method=INVITE 1(309) ERROR: <script>: route[REGISTRAR] start 2(310) ERROR: <script>: request_route start -- method=INVITE 2(310) ERROR: <script>: route[REGISTRAR] start 2(310) ERROR: <script>: request_route start -- method=ACK 1(309) NOTICE: acc [acc.c:275]: ACC: transaction answered: timestamp=1350034404;method=INVITE;from_tag=966002447;to_tag=3a8473f2;call_id= 331189810(a)192.168.10.2 ;code=200;reason=OK;src_user=Radio1_device;src_domain=testnet;src_ip=192.168.10.2;dst_ouser=Radio1;dst_user=3;dst_domain=192.168.10.2 3(311) NOTICE: acc [acc.c:275]: ACC: transaction answered: timestamp=1350034404;method=INVITE;from_tag=1718943109;to_tag=22a97aa7;call_id= 956233863(a)192.168.10.2 ;code=200;reason=OK;src_user=User3;src_domain=testnet;src_ip=192.168.10.2;dst_ouser=IC1;dst_user=1;dst_domain=192.168.10.2 3(311) ERROR: <script>: request_route start -- method=ACK 1(309) NOTICE: acc [acc.c:275]: ACC: transaction answered: timestamp=1350034404;method=INVITE;from_tag=1709043140;to_tag=4aa972a8;call_id= 780056350(a)192.168.10.2 ;code=200;reason=OK;src_user=User3;src_domain=testnet;src_ip=192.168.10.2;dst_ouser=IC2;dst_user=2;dst_domain=192.168.10.2 1(309) NOTICE: acc [acc.c:275]: ACC: transaction answered: timestamp=1350034404;method=INVITE;from_tag=1506064927;to_tag=5a73a3fc;call_id= 1129604628(a)192.168.10.2 ;code=200;reason=OK;src_user=User3;src_domain=testnet;src_ip=192.168.10.2;dst_ouser=emergency;dst_user=4;dst_domain=192.168.10.2 1(309) NOTICE: acc [acc.c:275]: ACC: transaction answered: timestamp=1350034404;method=INVITE;from_tag=1200029211;to_tag=14c6d7d4;call_id= 1214006622(a)192.168.10.2 ;code=200;reason=OK;src_user=User3;src_domain=testnet;src_ip=192.168.10.2;dst_ouser=Radio1;dst_user=3;dst_domain=192.168.10.2 1(309) ERROR: <script>: request_route start -- method=ACK 2(310) ERROR: <script>: request_route start -- method=ACK 3(311) ERROR: <script>: request_route start -- method=ACK 2(310) ERROR: <script>: request_route start -- method=REGISTER 2(310) ERROR: <script>: route[REGISTRAR] start 2(310) ERROR: <script>: route[REGISTRAR] saving location... 1(309) ERROR: <script>: request_route start -- method=REGISTER 1(309) ERROR: <script>: route[REGISTRAR] start 1(309) ERROR: <script>: route[REGISTRAR] saving location... 2(310) ERROR: <script>: route[REGISTRAR] saving location... done 1(309) ERROR: <script>: route[REGISTRAR] saving location... done 3(311) ERROR: <script>: request_route start -- method=INVITE 3(311) ERROR: <script>: route[REGISTRAR] start 3(311) ERROR: <script>: request_route start -- method=ACK 1(309) NOTICE: acc [acc.c:275]: ACC: transaction answered: timestamp=1350034419;method=INVITE;from_tag=22866096;to_tag=461b3848;call_id= 119348927(a)192.168.10.1 ;code=200;reason=OK;src_user=User1;src_domain=testnet;src_ip=192.168.10.1;dst_ouser=IC1;dst_user=1;dst_domain=192.168.10.2 2(310) ERROR: <script>: request_route start -- method=INVITE 2(310) ERROR: <script>: route[REGISTRAR] start 2(310) ERROR: <script>: request_route start -- method=ACK 3(311) NOTICE: acc [acc.c:275]: ACC: transaction answered: timestamp=1350034419;method=INVITE;from_tag=1086463804;to_tag=1b28a959;call_id= 1666188208(a)192.168.10.1 ;code=200;reason=OK;src_user=User1;src_domain=testnet;src_ip=192.168.10.1;dst_ouser=IC2;dst_user=2;dst_domain=192.168.10.2 1(309) ERROR: <script>: request_route start -- method=INVITE 1(309) ERROR: <script>: route[REGISTRAR] start 1(309) ERROR: <script>: request_route start -- method=ACK 2(310) NOTICE: acc [acc.c:275]: ACC: transaction answered: timestamp=1350034419;method=INVITE;from_tag=425688445;to_tag=7c6f5fd8;call_id= 138053674(a)192.168.10.1 ;code=200;reason=OK;src_user=User1;src_domain=testnet;src_ip=192.168.10.1;dst_ouser=emergency;dst_user=4;dst_domain=192.168.10.2 3(311) ERROR: <script>: request_route start -- method=INVITE 3(311) ERROR: <script>: route[REGISTRAR] start 3(311) ERROR: <script>: request_route start -- method=ACK 2(310) NOTICE: acc [acc.c:275]: ACC: transaction answered: timestamp=1350034419;method=INVITE;from_tag=2111220874;to_tag=6a7be79d;call_id= 1381530996(a)192.168.10.1 ;code=200;reason=OK;src_user=User1;src_domain=testnet;src_ip=192.168.10.1;dst_ouser=Radio1;dst_user=3;dst_domain=192.168.10.2 1(309) ERROR: <script>: request_route start -- method=INVITE 1(309) ERROR: <script>: route[REGISTRAR] start 1(309) ERROR: <script>: request_route start -- method=ACK 2(310) NOTICE: acc [acc.c:275]: ACC: transaction answered: timestamp=1350034419;method=INVITE;from_tag=269879616;to_tag=210d7864;call_id= 907816659(a)192.168.10.1 ;code=200;reason=OK;src_user=User2;src_domain=testnet;src_ip=192.168.10.1;dst_ouser=IC1;dst_user=1;dst_domain=192.168.10.2 3(311) ERROR: <script>: request_route start -- method=INVITE 3(311) ERROR: <script>: route[REGISTRAR] start 1(309) NOTICE: acc [acc.c:275]: ACC: transaction answered: timestamp=1350034419;method=INVITE;from_tag=1891265955;to_tag=29747a68;call_id= 1205241696(a)192.168.10.1 ;code=200;reason=OK;src_user=User2;src_domain=testnet;src_ip=192.168.10.1;dst_ouser=emergency;dst_user=4;dst_domain=192.168.10.2 3(311) ERROR: <script>: request_route start -- method=ACK 2(310) ERROR: <script>: request_route start -- method=INVITE 1(309) ERROR: <script>: request_route start -- method=INVITE 2(310) ERROR: <script>: request_route start -- method=ACK 2(310) ERROR: <script>: request_route start -- method=INVITE 3(311) ERROR: <script>: request_route start -- method=ACK 3(311) ERROR: <script>: request_route start -- method=INVITE 2(310) ERROR: <script>: request_route start -- method=INVITE <-- Last message from 2(310) 3(311) ERROR: <script>: request_route start -- method=ACK 3(311) ERROR: <script>: request_route start -- method=ACK 3(311) ERROR: <script>: request_route start -- method=ACK 1(309) ERROR: <script>: request_route start -- method=INVITE <-- Last message from 1(309) 3(311) ERROR: <script>: request_route start -- method=INVITE 3(311) ERROR: <script>: request_route start -- method=ACK 3(311) ERROR: <script>: request_route start -- method=INVITE 3(311) ERROR: <script>: request_route start -- method=ACK 3(311) ERROR: <script>: request_route start -- method=INVITE 3(311) ERROR: <script>: request_route start -- method=ACK 3(311) ERROR: <script>: request_route start -- method=INVITE 3(311) ERROR: <script>: request_route start -- method=ACK ... 3(311) ERROR: <script>: request_route start -- method=REGISTER 3(311) ERROR: <script>: route[REGISTRAR] start 3(311) ERROR: <script>: route[REGISTRAR] saving location... 3(311) ERROR: <script>: route[REGISTRAR] saving location... done 3(311) ERROR: <script>: request_route start -- method=INVITE <-- Last message