sr-dev May 2016

sr-dev@lists.kamailio.org

28 participants
349 discussions

[kamailio/kamailio] siptrace: HEPv2 destination port is sent as the wrong port (#581)
by Erik Davidson 14 Sep '16

14 Sep '16

I've been trying to track this issue down myself for the last two days but it appears the value is coming from somewhere in the tm module or somewhere else lower than that, which I haven't worked with at all. I have siptrace turned on and I'm using the destination port from the HEPv2 header but it seems to always come to me as 5060 even if the packet is actually sent to a different port (such as 51000). I'm able to reproduce this with my Polycom phone by having two registrations (one UDP and one TCP) going through a Kamailio server from the same phone. It looks like the first request comes from 5060 and is responded to on 5060, but the second connection comes from a random port on the phone (let's say 35000). When the reply (such as a 200) comes back from the server sitting behind the Kamailio proxy, the siptrace HEP header says the packet is going back to 5060 when it's actually being sent to 35000. I'm not even sure where the 5060 value is coming from in the first place . I've tracked the '5060' value to `t.uas.response.dst.to.sin.sin_port` in `t_reply.c:reply_received()` but the value of `t` is retrieved from `get_t()` and I'm not sure where that's added to the hash table in the first place. I can see the actual value of the destination port with `t.uas.request.rcv.src_port` within that same `t_reply.c:reply_received()` but I can't figure out how to get that value into the destination port at the source. --- You are receiving this because you are subscribed to this thread. Reply to this email directly or view it on GitHub: https://github.com/kamailio/kamailio/issues/581

2 4

[kamailio] kamailio crash on receive_fd (version: 4.2 , >4.2.6) (#466)
by BroWater 14 Sep '16

14 Sep '16

Hello, Situation: Use a client (MCU) to call other clients through kamailio and hang up these calls, repeatedly Suddenly some clients were found fail to register, crash on kamailio was confirmed after checking the following log: Jan 7 03:42:24 /kamailio[1425]: CRITICAL: <core> [pass_fdc:293]: receive_fd(): EOF on 11 Jan 7 03:42:24 /kamailio[1415]: ALERT: <core> [mainc:784]: handle_sigs(): child process 1416 exited by a signal 6 Jan 7 03:42:24 /kamailio[1415]: ALERT: <core> [mainc:787]: handle_sigs(): core was generated And here is the `bt full` output from the coredump file: --------------------------------------------------------------------------------------------------------- #0 0x401cd8e8 in raise () from /lib/libcso6 No symbol table info available #1 0x401d171c in abort () from /lib/libcso6 No symbol table info available #2 0x401c6bf0 in __assert_fail_base () from /lib/libcso6 No symbol table info available #3 0x401c6cb8 in __assert_fail () from /lib/libcso6 No symbol table info available #4 0x400cb0a8 in pthread_mutex_lock () from /lib/libpthreadso0 No symbol table info available #5 0x40cdccdc in add_uac (t=0x419eb780, request=0x40408d18, uri=0x40408e88, next_hop=0x40408e90, path=0x40409094, proxy=0x0, fsocket=0x0, snd_flags=, proto=0, flags=0, instance=0x4040909c, ruid=0x404090a8, location_ua=0x404090b0) at t_fwdc:863 ret = 0 branch = 0 __FUNCTION__ = "add_uac" #6 0x40ce5598 in t_forward_nonack (t=0x419eb780, p_msg=0x40408d18, proxy=0x0, proto=0) at t_fwdc:1723 branch_ret = 0 lowest_ret = -1 current_uri = {s = 0x0, len = 0} added_branches = 0 first_branch = 0 i = 1 q = 0 t_invite = 0xffffffff success_branch = 1 try_new = 1 lock_replies = -1093035388 dst_uri = {s = 0x376a88 "<core>: dsetc", len = 1093296396} path = {s = 0x0, len = 0} instance = {s = 0xbed99a5c "\200\325\314@\034\342>@\204\342-@x\021\002", len = 1087391576} ruid = {s = 0x0, len = 1073991680} location_ua = {s = 0x21178 "", len = 0} si = 0x0 backup_bflags = 0 bflags = 0 __FUNCTION__ = "t_forward_nonack" #7 0x40ccd580 in t_relay_to (p_msg=0x40408d18, proxy=0x0, proto=0, replicate=0) at t_funcsc:355 ret = 0 new_tran = 1 t = 0x419eb780 dst = {send_sock = 0x40408d18, to = {s = {sa_family = 40716, sa_data = "\331\276\030\215@@\004\301\003A8\342>@"}, sin = {sin_family = 40716, sin_port = 48857, sin_addr = {s_addr = 1077972248}, sin_zero = "\004\301\003A8\342>@"}, sin6 = {sin6_family = 40716, sin6_port = 48857, sin6_flowinfo = 1077972248, sin6_addr = { __in6_u = {__u6_addr8 = "\004\301\003A8\342>@\000\000\000\000\fa*A", __u6_addr16 = {49412, 16643, 57912, 16446, 0, 0, 24844, 16682}, __u6_addr32 = { 1090765060, 1077862968, 0, 1093296396}}}, sin6_scope_id = 0}}, id = 135544, proto = 0 '\000', send_flags = {f = 0 '\000', blst_imask = 0 '\000'}} port = 48857 host = {s = 0x4031c534 "\001", len = 1077972248} comp = -1 __FUNCTION__ = "t_relay_to" #8 0x40d1cb98 in _w_t_relay_to (p_msg=0x40408d18, proxy=0x0, force_proto=0) at tmc:1517 t = 0x41086c80 res = -1093035156 __FUNCTION__ = "_w_t_relay_to" #9 0x40d1e1f4 in w_t_relay (p_msg=0x40408d18, _foo=0x0, _bar=0x0) at tmc:1718 No locals #10 0x00029aa0 in do_action (h=0xbed99fc8, a=0x40320f74, msg=0x40408d18) at actionc:1088 ret = -5 v = -1093034460 dst = {send_sock = 0x4036ee58, to = {s = {sa_family = 36120, sa_data = "@@\001\000\000\000`OK\000\324\235\331\276"}, sin = {sin_family = 36120, sin_port = 16448, sin_addr = {s_addr = 1}, sin_zero = "`OK\000\324\235\331\276"}, sin6 = {sin6_family = 36120, sin6_port = 16448, sin6_flowinfo = 1, sin6_addr = {__in6_u = { __u6_addr8 = "`OK\000\324\235\331\276\000\000\000\000\000\000\000", __u6_addr16 = {20320, 75, 40404, 48857, 0, 0, 0, 0}, __u6_addr32 = {4935520, 3201932756, 0, 0}}}, sin6_scope_id = 3201932896}}, id = 1077341784, proto = 24 '\030', send_flags = {f = 141 '\215', blst_imask = 64 '@'}} tmp = 0x4003d000 "H\377\002" new_uri = 0x0 end = 0xd72a4 "" crt = 0x0 cmd = 0x402ff898 len = 0 user = 135544 uri = {user = {s = 0x0, len = 0}, passwd = {s = 0x0, len = 0}, host = {s = 0x0, len = 1610612752}, port = {s = 0x8a <Address 0x8a out of bounds>, len = 2623776}, params = {s = 0x121822c7 <Address 0x121822c7 out of bounds>, len = -1093034636}, sip_params = {s = 0x98f6c " ", len = 1077000232}, headers = {s = 0xbed99e78 "", len = 1077972248}, port_no = 46240, proto = 48857, type = 3727636, flags = 8388608, transport = {s = 0x6e9c68 <Address 0x6e9c68 out of bounds>, len = 967680}, ttl = {s = 0xbed99d7c "\001", len = 22}, user_param = {s = 0x4b4f4c "", len = 0}, maddr = {s = 0xbed99d5c "", len = 19}, method = {s = 0xbed99d84 "", len = 303571655}, lr = {s = 0x0, len = 135544}, r2 = {s = 0x0, len = 0}, gr = {s = 0xbed99d8c "\b\230\021", len = 1152864}, transport_val = { s = 0xbed99db0 "\001", len = 22}, ttl_val = {s = 0x4b4f4c "", len = 1}, user_param_val = {s = 0x280920 "\b0\033\345\004 \223\345\f0\033\345", len = 1}, maddr_val = {s = 0x4b4f60 "2", len = 0}, method_val = {s = 0xbed99d9c "$\341\021", len = 1153032}, lr_val = {s = 0x0, len = 1}, r2_val = {s = 0xbed99dbc "", len = 1171748}, gr_val = {s = 0x1 <Address 0x1 out of bounds>, len = -1093034400}} next_hop = {user = {s = 0xbed99c3c "", len = 1077972248}, passwd = {s = 0x4032aaac "0\003", len = -1093034880}, host = {s = 0x40408d18 "l\006", len = 1076849808}, port = {s = 0x3 <Address 0x3 out of bounds>, len = 0}, params = {s = 0x40317840 "", len = 1077972248}, sip_params = { s = 0xffffffff <Address 0xffffffff out of bounds>, len = 1076983872}, headers = {s = 0x121822c7 <Address 0x121822c7 out of bounds>, len = 0}, port_no = 4472, proto = 2, type = ERROR_URI_T, flags = 0, transport = {s = 0x4003d000 "H\377\002", len = -1093033948}, ttl = {s = 0x29b18 "", len = 0}, user_param = { s = 0x40408d18 "l\006", len = 1077062316}, maddr = {s = 0xbed9b4a0 "\004", len = 0}, method = {s = 0x0, len = -1}, lr = { s = 0xbed99cac "l\234\331\276\370\233\331\276hi\003", len = 303571655}, r2 = {s = 0x0, len = 135544}, gr = {s = 0x40408d18 "l\006", len = 1077018000}, transport_val = {s = 0xbed9a0b0 "", len = 1073991680}, ttl_val = {s = 0xbed99c6c "\030\233\002", len = -1093035016}, user_param_val = {s = 0x36968 "", 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 = 0x0 port = 4632 dst_host = 0x4032abdc i = 4104020 flags = -1093034948 avp = 0x40310d88 st = {flags = 0, id = 0, name = {n = 1610612752, s = {s = 0x60000010 <Address 0x60000010 out of bounds>, len = 567153825}, re = 0x60000010}, avp = 0x280920} sct = 0x128264 sjt = 0x0 rve = 0x4 mct = 0x40408d18 rv = 0x4101b35c rv1 = 0x40408d18 c1 = {cache_type = RV_CACHE_EMPTY, val_type = 303571655, c = {avp_val = {n = 0, s = {s = 0x0, len = 135544}, re = 0x0}, pval = {rs = {s = 0x0, len = 135544}, ri = 0, flags = 0}}, i2s = "\000\320\003@l\234\331\276\350l\003\000\003\000\000\000\377\377\377\377l\234"} s = {s = 0x36968 "", len = 0} srevp = {0xbed99b84, 0xbed99b10} mod_f_params = {{type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NUMBER_ST, u = { number = 2, string = 0x2 <Address 0x2 out of bounds>, str = {s = 0x2 <Address 0x2 out of bounds>, len = 0}, data = 0x2, attr = 0x2, select = 0x2}}, { type = RVE_FREE_FIXUP_ST, u = {number = 0, string = 0x0, str = {s = 0x0, len = 3}, data = 0x0, attr = 0x0, select = 0x0}}, {type = MODFIXUP_ST, u = { number = 1077333124, string = 0x4036cc84 "X\314\066@ ", str = {s = 0x4036cc84 "X\314\066@ ", len = 3}, data = 0x4036cc84, attr = 0x4036cc84, select = 0x4036cc84}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}} __FUNCTION__ = "do_action" #11 0x00036ce8 in run_actions (h=0xbed99fc8, a=0x40320f74, msg=0x40408d18) at actionc:1583 t = 0x40320f74 ret = -1 mod = 0x0 ms = 0 __FUNCTION__ = "run_actions" #12 0x00037478 in run_actions_safe (h=0xbed9b4a0, a=0x40320f74, msg=0x40408d18) at actionc:1648 ctx = {rec_lev = 1, run_flags = 0, last_retcode = 0, jmp_env = {{__jmpbuf = {303571655, 0, 135544, 0, 0, 0, 1073991680, -1093034060, -1093034176, 223592, 0 <repeats 16 times>, 1610612752, 1100845520, 1416, 1100429564, 1164518012, 1077972248, 1077018000, -1093033808, 0, 1073991680, 1, 0, 0, 1077972248, -1, 0, 303571655, 303571655, 0, 135544, 0, 0, -1093033388, 226424, 0, 1077972248, 1077018000, -1093028704, 0, 0, -1, 1164092908, 303571655, 0, 135544, 0, 0, 0}, __mask_was_saved = 0, __saved_mask = {__val = {3201933468, 3201933352, 223592, 0 <repeats 16 times>, 1610612752, 3, 2623776, 3201933652, 0, 5, 3201933692, 1085865828, 7249368, 1077864140, 4849333, 4849164, 8}}}}} ret = -1 ign_on_break = 0 #13 0x0017ed68 in rval_get_int (h=0xbed9b4a0, msg=0x40408d18, i=0xbed9a390, rv=0x40321184, cache=0x0) at rvaluec:924 r_avp = 0x40408d18 avp_val = {n = 0, s = {s = 0x0, len = 4848947}, re = 0x0} pval = {rs = {s = 0x3dc238 "parse_headers", len = 4035544}, ri = 1077864140, flags = 1076748296} tmp = {s = 0x0, len = 5} s = 0x0 r = 0 ret = 0 destroy_pval = 0 __FUNCTION__ = "rval_get_int" #14 0x00183b3c in rval_expr_eval_int (h=0xbed9b4a0, msg=0x40408d18, res=0xbed9a390, rve=0x40321180) at rvaluec:1918 i1 = 5060 i2 = 1077972248 ret = -1 c1 = {cache_type = 135544, val_type = 1077018528, c = {avp_val = {n = -1093032424, s = {s = 0xbed9a618 "", len = 1077972248}, re = 0xbed9a618}, pval = {rs = { s = 0xbed9a618 "", len = 1077972248}, ri = -1093028704, flags = -1093033244}}, i2s = "\340r\346@\344\242\331\276$\211\344@\001\000\000\000\000\000\000\224"} c2 = {cache_type = 137, val_type = 4294967295, c = {avp_val = {n = 0, s = {s = 0x0, len = -1093033244}, re = 0x0}, pval = {rs = {s = 0x0, len = -1093033244}, ri = 1568104, flags = 192}}, i2s = "\000\000\000\000\b\000\000\000\220\221\235A\000\000\000\000\364@\347@\000"} rv1 = 0x0 rv2 = 0x402de008 __FUNCTION__ = "rval_expr_eval_int" #15 0x00183f00 in rval_expr_eval_int (h=0xbed9b4a0, msg=0x40408d18, res=0xbed9a618, rve=0x40321524) at rvaluec:1926 i1 = 0 i2 = -1093028704 ret = -1 c1 = {cache_type = RV_CACHE_EMPTY, val_type = RV_NONE, c = {avp_val = {n = 0, s = {s = 0x0, len = 0}, re = 0x0}, pval = {rs = {s = 0x0, len = 0}, ri = 0, flags = 0}}, i2s = "\000\000\000\000\000F0@\000\000\000\000\000\000\000\000\030\215@@\324\260"} c2 = {cache_type = 12, val_type = 4848849, c = {avp_val = {n = 4, s = {s = 0x4 <Address 0x4 out of bounds>, len = 303571655}, re = 0x4}, pval = {rs = { s = 0x4 <Address 0x4 out of bounds>, len = 303571655}, ri = 0, flags = 135544}}, i2s = "\000\000\000\000\000\000\000\000\000\320\003@\314\243\331\276\350l\003\000\000"} rv1 = 0x49fcc4 rv2 = 0x0 __FUNCTION__ = "rval_expr_eval_int" #16 0x00029600 in do_action (h=0xbed9b4a0, a=0x403218c8, msg=0x40408d18) at actionc:1064 ret = -5 v = 0 dst = {send_sock = 0x0, to = {s = {sa_family = 33508, sa_data = ">\000\240\325=\000\001\000\000\000\004\000\000"}, sin = {sin_family = 33508, sin_port = 62, sin_addr = {s_addr = 4052384}, sin_zero = "\001\000\000\000\004\000\000"}, sin6 = {sin6_family = 33508, sin6_port = 62, sin6_flowinfo = 4052384, sin6_addr = { __in6_u = {__u6_addr8 = "\001\000\000\000\004\000\000\000\300\247\331\276\000\000\000", __u6_addr16 = {1, 0, 4, 0, 42944, 48857, 0, 0}, __u6_addr32 = {1, 4, 3201935296, 0}}}, sin6_scope_id = 303571655}}, id = 0, proto = 199 '\307', send_flags = {f = 34 '"', blst_imask = 24 '\030'}} tmp = 0x0 new_uri = 0x3 <Address 0x3 out of bounds> end = 0xbed9a714 "<;\030" crt = 0x0 cmd = 0x40329d38 len = 0 user = 135544 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}, sip_params = { s = 0x0, len = 1610612752}, headers = {s = 0x121822c7 <Address 0x121822c7 out of bounds>, len = -1093032500}, port_no = 36716, proto = 9, type = 7, flags = 5, transport = {s = 0x40312380 "\001", len = -1093032232}, ttl = {s = 0x40408d18 "l\006", len = -1093028704}, user_param = {s = 0xbed9a59c "h\355\027", len = 1077572256}, maddr = {s = 0x0, len = 5}, method = {s = 0x1 <Address 0x1 out of bounds>, len = 0}, lr = {s = 0xbed9a62c "0?\030", len = 1568104}, r2 = { s = 0x6e9894 <Address 0x6e9894 out of bounds>, len = 968660}, gr = {s = 0x6 <Address 0x6 out of bounds>, len = 0}, transport_val = { s = 0x3dc7b4 "<core>: parser/parse_addr_specc", len = 303571655}, ttl_val = {s = 0x0, len = 135544}, user_param_val = {s = 0x0, len = 0}, maddr_val = { s = 0xbed9a63c "\214M)", len = 2604464}, method_val = {s = 0x3dd5a0 "parse_to_param", len = 285}, lr_val = {s = 0x40304600 "l?\002A\020\070\001A\001", len = 0}, r2_val = {s = 0x0, len = 0}, gr_val = {s = 0x0, len = 5}} next_hop = {user = {s = 0x0, len = 0}, passwd = {s = 0x0, len = 0}, host = {s = 0x0, len = 0}, port = {s = 0x0, len = 1077972248}, params = {s = 0x40329c04 "%\003", len = -1093032736}, sip_params = {s = 0x0, len = 0}, headers = {s = 0x121822c7 <Address 0x121822c7 out of bounds>, len = 0}, port_no = 0, proto = 0, type = ERROR_URI_T, flags = 4294967295, transport = {s = 0x0, len = -1093032756}, ttl = {s = 0x121822c7 <Address 0x121822c7 out of bounds>, len = 0}, user_param = { s = 0x21178 "", len = 0}, maddr = {s = 0x0, len = -1093032316}, method = {s = 0x37478 "\f", len = 141}, lr = {s = 0x40408d18 "l\006", len = 1077058564}, r2 = { s = 0xbed9b4a0 "\004", len = 0}, gr = {s = 0x0, len = -1}, transport_val = {s = 0x403a72a0 "\002", len = 303571655}, ttl_val = {s = 0x0, len = 135544}, user_param_val = {s = 0x0, len = 0}, maddr_val = {s = 0x0, len = 1073991680}, method_val = {s = 0xbed9a4cc "xt\003", len = -1093032872}, lr_val = {s = 0x36968 "", len = 0}, r2_val = {s = 0x0, len = 0}, gr_val = {s = 0x0, len = 0}} u = 0x0 port = 4632 dst_host = 0xbed9a8e4 i = -1093028704 flags = 1088786032 avp = 0x40408d18 st = {flags = 3201934540, id = 27880, name = {n = 0, s = {s = 0x0, len = 1073991680}, re = 0x0}, avp = 0xbed9a4b4} sct = 0x0 sjt = 0x121822c7 rve = 0x40321524 mct = 0x403ef9e0 rv = 0x4003d000 rv1 = 0xbed9aa48 c1 = {cache_type = 3201935400, val_type = 331612160, c = {avp_val = {n = 1, s = {s = 0x1 <Address 0x1 out of bounds>, len = 0}, re = 0x1}, pval = {rs = { s = 0x1 <Address 0x1 out of bounds>, len = 0}, ri = 1077972248, flags = 4848957}}, i2s = "\001\000\000\000\307\"\030\022\000\000\000\000x\021\002\000\000\000\000\000\000"} s = {s = 0x40e47ce8 "", len = 0} srevp = {0x40e474f0, 0xbed9a464} mod_f_params = {{type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NUMBER_ST, u = { number = 2, string = 0x2 <Address 0x2 out of bounds>, str = {s = 0x2 <Address 0x2 out of bounds>, len = 0}, data = 0x2, attr = 0x2, select = 0x2}}, { type = RVE_FREE_FIXUP_ST, u = {number = 0, string = 0x0, str = {s = 0x0, len = 3}, data = 0x0, attr = 0x0, select = 0x0}}, {type = MODFIXUP_ST, u = { number = 1077333124, string = 0x4036cc84 "X\314\066@ ", str = {s = 0x4036cc84 "X\314\066@ ", len = 3}, data = 0x4036cc84, attr = 0x4036cc84, select = 0x4036cc84}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}} __FUNCTION__ = "do_action" #17 0x00036ce8 in run_actions (h=0xbed9b4a0, a=0x4031ea14, msg=0x40408d18) at actionc:1583 t = 0x403218c8 ret = 1 mod = 0x0 ms = 0 __FUNCTION__ = "run_actions" #18 0x000263ac in do_action (h=0xbed9b4a0, a=0x4032b32c, msg=0x40408d18) at actionc:712 ret = -5 v = 0 dst = {send_sock = 0x0, to = {s = {sa_family = 24, sa_data = "\000\000\002\375I\000\000\000\000\000\320\220\235A"}, sin = {sin_family = 24, sin_port = 0, sin_addr = { s_addr = 4848898}, sin_zero = "\000\000\000\000\320\220\235A"}, sin6 = {sin6_family = 24, sin6_port = 0, sin6_flowinfo = 4848898, sin6_addr = {__in6_u = { __u6_addr8 = "\000\000\000\000\320\220\235A\000\000\000\000\000\000\000", __u6_addr16 = {0, 0, 37072, 16797, 0, 0, 0, 0}, __u6_addr32 = {0, 1100845264, 0, 0}}}, sin6_scope_id = 0}}, id = 0, proto = 199 '\307', send_flags = {f = 34 '"', blst_imask = 24 '\030'}} tmp = 0xbed9abb4 "\350l\003" new_uri = 0x121822c7 <Address 0x121822c7 out of bounds> end = 0x403ebfec "\232\301>@\030" crt = 0x280920 "\b0\033\345\004 \223\345\f0\033\345" cmd = 0x40329698 len = 0 user = 1077034684 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}, sip_params = { s = 0x0, len = 1610612752}, headers = {s = 0x0, len = 0}, port_no = 0, proto = 0, type = 18, flags = 0, transport = {s = 0x40326164 "\001", len = -1093031160}, ttl = {s = 0x40408d18 "l\006", len = -1093028704}, user_param = {s = 0xbed9a9cc "h\355\027", len = 1076748296}, maddr = { s = 0xbed9a9f4 "\360\253\331\276\030\215@@\240\264\331\276\004", len = 1085865828}, method = {s = 0x1 <Address 0x1 out of bounds>, len = 0}, lr = { s = 0xbed9aa5c "<;\030", len = 1568104}, r2 = {s = 0x6e9a90 <Address 0x6e9a90 out of bounds>, len = 968152}, gr = { s = 0x116570 "\004\060\240\343\202!\240\341\002 \201\340\003\060\202\340", len = 1215756}, transport_val = {s = 0x4 <Address 0x4 out of bounds>, len = 145}, ttl_val = {s = 0x0, len = 303571655}, user_param_val = {s = 0x40328d8c "\004", len = -1093030928}, maddr_val = {s = 0x40408d18 "l\006", len = -1093028704}, method_val = {s = 0x4 <Address 0x4 out of bounds>, len = 1091096887}, lr_val = {s = 0xb <Address 0xb out of bounds>, len = 1091096872}, r2_val = {s = 0x0, len = 0}, gr_val = {s = 0x0, len = 5}} next_hop = {user = {s = 0x0, len = 0}, passwd = {s = 0x60000010 <Address 0x60000010 out of bounds>, len = 56}, host = {s = 0x403636c0 "\n", len = 3}, port = { s = 0x2 <Address 0x2 out of bounds>, len = 1077972248}, params = {s = 0x40329600 "#\003", len = -1093031664}, sip_params = { s = 0x121822c7 <Address 0x121822c7 out of bounds>, len = 1076733136}, headers = {s = 0x12 <Address 0x12 out of bounds>, len = 0}, port_no = 0, proto = 0, type = 1077972248, flags = URI_USER_NORMALIZE, transport = {s = 0x0, len = 303571655}, ttl = {s = 0x121822c7 <Address 0x121822c7 out of bounds>, len = 0}, user_param = {s = 0x21178 "", len = 0}, maddr = {s = 0x0, len = -1093031244}, method = {s = 0x37478 "\f", len = 1077972248}, lr = {s = 0x40408d18 "l\006", len = 1077057024}, r2 = {s = 0xbed9b4a0 "\004", len = 0}, gr = {s = 0x0, len = 1}, transport_val = {s = 0x40408d18 "l\006", len = 303571655}, ttl_val = {s = 0x0, len = 135544}, user_param_val = {s = 0x0, len = 0}, maddr_val = {s = 0x0, len = 1073991680}, method_val = {s = 0xbed9a8fc "xt\003", len = -1093031800}, lr_val = { s = 0x36968 "", len = 0}, r2_val = {s = 0x0, len = 0}, gr_val = {s = 0x0, len = 0}} u = 0x403242fc port = 48857 dst_host = 0x40408d18 i = 2 flags = 0 avp = 0x40408d18 st = {flags = 3201935612, id = 27880, name = {n = 0, s = {s = 0x0, len = 0}, re = 0x0}, avp = 0x0} sct = 0x403636a8 sjt = 0x40408d18 rve = 0x40329d34 mct = 0x113 rv = 0x4003d000 rv1 = 0xbed9ae78 c1 = {cache_type = RV_CACHE_EMPTY, val_type = 1073991680, c = {avp_val = {n = -1093031916, s = {s = 0xbed9a814 "xt\003", len = -1093032032}, re = 0xbed9a814}, pval = { rs = {s = 0xbed9a814 "xt\003", len = -1093032032}, ri = 223592, flags = 0}}, i2s = "\000\000\000\000\307\"\030\022\000\000\000\000x\021\002\000\000\000\000\000\000"} s = {s = 0x0, len = 0} srevp = {0x0, 0x21178} mod_f_params = {{type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NUMBER_ST, u = { number = 2, string = 0x2 <Address 0x2 out of bounds>, str = {s = 0x2 <Address 0x2 out of bounds>, len = 0}, data = 0x2, attr = 0x2, select = 0x2}}, { type = RVE_FREE_FIXUP_ST, u = {number = 0, string = 0x0, str = {s = 0x0, len = 3}, data = 0x0, attr = 0x0, select = 0x0}}, {type = MODFIXUP_ST, u = { number = 1077333124, string = 0x4036cc84 "X\314\066@ ", str = {s = 0x4036cc84 "X\314\066@ ", len = 3}, data = 0x4036cc84, attr = 0x4036cc84, select = 0x4036cc84}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}} __FUNCTION__ = "do_action" #19 0x00036ce8 in run_actions (h=0xbed9b4a0, a=0x40329ad4, msg=0x40408d18) at actionc:1583 t = 0x4032b32c ret = 1 mod = 0x0 ms = 0 __FUNCTION__ = "run_actions" #20 0x00029a2c in do_action (h=0xbed9b4a0, a=0x4032b454, msg=0x40408d18) at actionc:1079 ret = 1 v = 1 dst = {send_sock = 0x0, to = {s = {sa_family = 64960, sa_data = " @\b \000\000pD!@\340\070U"}, sin = {sin_family = 64960, sin_port = 16416, sin_addr = { s_addr = 8200}, sin_zero = "pD!@\340\070U"}, sin6 = {sin6_family = 64960, sin6_port = 16416, sin6_flowinfo = 8200, sin6_addr = {__in6_u = { __u6_addr8 = "pD!@\340\070U\000\000\240-@\000\000\000", __u6_addr16 = {17520, 16417, 14560, 85, 40960, 16429, 0, 0}, __u6_addr32 = {1075922032, 5585120, 1076731904, 0}}}, sin6_scope_id = 1}}, id = 0, proto = 21 '\025', send_flags = {f = 0 '\000', blst_imask = 0 '\000'}} tmp = 0x4108cee0 "xlog" new_uri = 0x4109e174 "\214\240\001" end = 0x79 <Address 0x79 out of bounds> crt = 0x4 <Address 0x4 out of bounds> cmd = 0x403152a0 len = 135544 user = 0 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}, sip_params = { s = 0x0, len = 1610612752}, headers = {s = 0x402da228 "\001", len = 134217728}, port_no = 0, proto = 13362, type = 1076597596, flags = 1076611795, transport = { s = 0x402da228 "\001", len = 5585624}, ttl = {s = 0x402da4d0 "", len = 132392}, user_param = {s = 0x555a60 "", len = 124320}, maddr = {s = 0x555a60 "", len = 1075903936}, method = {s = 0xbed9ae9f "A\373\037", len = 1076728908}, lr = {s = 0x1 <Address 0x1 out of bounds>, len = 1076731904}, r2 = { s = 0x1 <Address 0x1 out of bounds>, len = 0}, gr = {s = 0x3 <Address 0x3 out of bounds>, len = -1093030216}, transport_val = {s = 0x402b73cc "%H:%M:%S", len = 1076731904}, ttl_val = {s = 0x402d926c ",t+@", len = 5585496}, user_param_val = {s = 0x402da4d0 "", len = 8200}, maddr_val = { s = 0x80 <Address 0x80 out of bounds>, len = 8200}, method_val = {s = 0xbed9af60 "", len = 5593696}, lr_val = {s = 0x402da228 "\001", len = 5585112}, r2_val = { s = 0x402da4d0 "", len = 132904}, gr_val = {s = 0x553ad8 "failed\n", len = 132392}} next_hop = {user = { s = 0x419d4700 "4 CIF=1;QCIF=1\r\na=rtpmap:31 H261/90000\r\na=fmtp:31 CIF=2;QCIF=2\r\na=sendrecv\r\nm=application 30006 RTP/SAVP 100\r\na=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:iBuE6kKiNbn30g7hkU2/qRE0ROKMAJZDD/Zg48t0\r\na=encr", len = 0}, passwd = {s = 0x419d4a44 "\220\001", len = 1100826908}, host = {s = 0x0, len = 5}, port = { s = 0x419d4a9c "\001", len = 1077972248}, params = {s = 0x40315020 "\226\002", len = -1093030592}, sip_params = {s = 0x49feb5 "", len = 4849103}, headers = { s = 0x8 <Address 0x8 out of bounds>, len = 0}, port_no = 0, proto = 0, type = 1089616044, flags = 4294967295, transport = {s = 0x0, len = 0}, ttl = { s = 0x121822c7 <Address 0x121822c7 out of bounds>, len = 0}, user_param = {s = 0x21178 "", len = 0}, maddr = {s = 0x0, len = -1093030172}, method = { s = 0x37478 "\f", len = 1100827356}, lr = {s = 0x40408d18 "l\006", len = 1076973600}, r2 = {s = 0xbed9b4a0 "\004", len = 0}, gr = {s = 0x0, len = -1}, transport_val = {s = 0x40231380 "\b0\235\345\003`\206\340\336\372\377\352\v", len = 303571655}, ttl_val = {s = 0x0, len = 135544}, user_param_val = {s = 0x0, len = 0}, maddr_val = {s = 0x0, len = 1073991680}, method_val = {s = 0xbed9ad2c "xt\003", len = -1093030728}, lr_val = {s = 0x36968 "", len = 0}, r2_val = { s = 0x0, len = 0}, gr_val = {s = 0x0, len = 0}} u = 0x4109e174 port = 48857 dst_host = 0x1 i = -1093028704 flags = -1 avp = 0x40408d18 st = {flags = 3201936684, id = 27880, name = {n = 152, s = {s = 0x98 <Address 0x98 out of bounds>, len = 1100827388}, re = 0x98}, avp = 0xffffffff} sct = 0x403ece20 sjt = 0x40408d18 rve = 0x40329694 mct = 0x402d944c rv = 0x4003d000 rv1 = 0xbed9b2a8 c1 = {cache_type = 4849103, val_type = 1452104383, c = {avp_val = {n = 0, s = {s = 0x0, len = 0}, re = 0x0}, pval = {rs = {s = 0x0, len = 0}, ri = 8388608, flags = 7249432}}, i2s = "\254\070\362@\307\"\030\022\000\000\000\000x\021\002\000\000\000\000\000\000"} s = {s = 0x403ff4fc "\033", len = 4849333} srevp = {0xbed9ac8c, 0xbed9ac8c} mod_f_params = {{type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NUMBER_ST, u = { number = 2, string = 0x2 <Address 0x2 out of bounds>, str = {s = 0x2 <Address 0x2 out of bounds>, len = 0}, data = 0x2, attr = 0x2, select = 0x2}}, { type = RVE_FREE_FIXUP_ST, u = {number = 0, string = 0x0, str = {s = 0x0, len = 3}, data = 0x0, attr = 0x0, select = 0x0}}, {type = MODFIXUP_ST, u = { number = 1077333124, string = 0x4036cc84 "X\314\066@ ", str = {s = 0x4036cc84 "X\314\066@ ", len = 3}, data = 0x4036cc84, attr = 0x4036cc84, select = 0x4036cc84}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}} __FUNCTION__ = "do_action" #21 0x00036ce8 in run_actions (h=0xbed9b4a0, a=0x403294d0, msg=0x40408d18) at actionc:1583 t = 0x4032b454 ret = 1 mod = 0x4003d000 ms = 0 __FUNCTION__ = "run_actions" #22 0x000263ac in do_action (h=0xbed9b4a0, a=0x403160fc, msg=0x40408d18) at actionc:712 ret = -5 v = 0 dst = {send_sock = 0x115f68, to = {s = {sa_family = 36108, sa_data = "\022\000\004\000\000\000\240\000\000\000\364\360\334@"}, sin = {sin_family = 36108, sin_port = 18, sin_addr = {s_addr = 4}, sin_zero = "\240\000\000\000\364\360\334@"}, sin6 = {sin6_family = 36108, sin6_port = 18, sin6_flowinfo = 4, sin6_addr = {__in6_u = {__u6_addr8 = "\240\000\000\000\364\360\334@\307\"\030\022\004\263\331\276", __u6_addr16 = {160, 0, 61684, 16604, 8903, 4632, 45828, 48857}, __u6_addr32 = {160, 1088221428, 303571655, 3201938180}}}, sin6_scope_id = 1077862732}}, id = 0, proto = 0 '\000', send_flags = {f = 208 '\320', blst_imask = 3 '\003'}} tmp = 0x40e43104 "\f\220\002" new_uri = 0x121822c7 <Address 0x121822c7 out of bounds> end = 0x49fcb8 "Route: <sip:101009336:5060;nat=yes;lr=on>\r\nFrom: <sip:1000@101009336:5060>;tag=875590146\r\nTo: <sip:9144@101009336:5060>;tag=748310794\r\nCall-ID: 54544907\r\nCSeq: 6 INFO\r\nContact: <sip:1000@101" crt = 0x21178 "" cmd = 0x40304fe0 len = 626540 user = -1093028780 uri = {user = { s = 0x49fc9f "branch=z9hG4bK897806495\r\nRoute: <sip:101009336:5060;nat=yes;lr=on>\r\nFrom: <sip:1000@101009336:5060>;tag=875590146\r\nTo: <sip:9144@101009336:5060>;tag=748310794\r\nCall-ID: 54544907\r\nCSeq: 6 INFO", len = 0}, passwd = {s = 0x0, len = -1093029204}, host = {s = 0x40d588cc "<0\033\345\002\001", len = 2042}, port = {s = 0x7d8 <Address 0x7d8 out of bounds>, len = 1077972248}, params = { s = 0x49fc8c "09336:5062;rport;branch=z9hG4bK897806495\r\nRoute: <sip:101009336:5060;nat=yes;lr=on>\r\nFrom: <sip:1000@101009336:5060>;tag=875590146\r\nTo: <sip:9144@101009336:5060>;tag=748310794\r\nCall-ID: 545", len = 4115756}, sip_params = {s = 0x3ebab8 "<core>: parser/parse_viac", len = 32}, headers = { s = 0x402de008 "\001", len = 0}, port_no = 12660, proto = 16799, type = 98365684, flags = 4848822, transport = {s = 0x403ee130 " ", len = -1093029288}, ttl = { s = 0x4 <Address 0x4 out of bounds>, len = 4848788}, user_param = { s = 0x49fc98 ";rport;branch=z9hG4bK897806495\r\nRoute: <sip:101009336:5060;nat=yes;lr=on>\r\nFrom: <sip:1000@101009336:5060>;tag=875590146\r\nTo: <sip:9144@101009336:5060>;tag=748310794\r\nCall-ID: 54544907\r\nCSeq:", len = 4848792}, maddr = {s = 0x4 <Address 0x4 out of bounds>, len = 331743235}, method = { s = 0xbed9b374 "$b(", len = -1093029004}, lr = {s = 0x403ee14c "\350", len = 1077933164}, r2 = {s = 0xbed9b2a4 "", len = 1100951944}, gr = {s = 0xbed9b4d8 "", len = 1}, transport_val = {s = 0xffffffff <Address 0xffffffff out of bounds>, len = -1}, ttl_val = {s = 0xbed9b2ac "\373\377\377\377\310\264\331\276\001", len = 1077933164}, user_param_val = {s = 0x49feb5 "", len = 4848763}, maddr_val = {s = 0x0, len = 84271112}, method_val = {s = 0xbed9b29c "L\341>@", len = 1085865828}, lr_val = {s = 0x419f31e0 "\310", len = 0}, r2_val = {s = 0x4 <Address 0x4 out of bounds>, len = 8388608}, gr_val = { s = 0x6ea098 <Address 0x6ea098 out of bounds>, len = 966608}} next_hop = {user = {s = 0x0, len = 135544}, passwd = {s = 0x280920 "\b0\033\345\004 \223\345\f0\033\345", len = -1093029596}, host = {s = 0xbed9b124 "", len = 1076748296}, port = {s = 0xbed9b14c "l\217\t", len = 1085865828}, params = {s = 0x0, len = 0}, sip_params = {s = 0x0, len = 8388608}, headers = { s = 0x6ea058 <Address 0x6ea058 out of bounds>, len = 966672}, port_no = 24488, proto = 17, type = 1215756, flags = 4, transport = { s = 0x9e <Address 0x9e out of bounds>, len = 0}, ttl = {s = 0x121822c7 <Address 0x121822c7 out of bounds>, len = -1093029452}, user_param = {s = 0x98f6c " ", len = 109}, maddr = {s = 0x40addfec "", len = -1093029428}, method = {s = 0x27d028 "\004", len = 4}, lr = {s = 0x3e9fa4 "core", len = 0}, r2 = { s = 0x3 <Address 0x3 out of bounds>, len = -1093029340}, gr = {s = 0x2e14d0 "", len = 0}, transport_val = {s = 0x0, len = -1093029428}, ttl_val = { s = 0xbed9b1cc "\314\210\325@\372\a", len = 1088115668}, user_param_val = {s = 0x40db0528 "tm: t_replyc", len = 8}, maddr_val = {s = 0x0, len = 4111032}, method_val = {s = 0x121822c7 <Address 0x121822c7 out of bounds>, len = 0}, lr_val = {s = 0x21178 "", len = 0}, r2_val = {s = 0x0, len = -1093029282}, gr_val = { s = 0xbed9b25f "\005\234\262\331\276d\377\270@\340\061\237A", len = 4849333}} u = 0x157 port = 61 dst_host = 0x8 i = 4 flags = 626540 avp = 0xbed9b44c st = {flags = 4, id = 141, name = {n = 343, s = {s = 0x157 <Address 0x157 out of bounds>, len = 1088221428}, re = 0x157}, avp = 0xbed9b15c} sct = 0x1d sjt = 0x40408d18 rve = 0x4031529c mct = 0x49fddf rv = 0x128d0c rv1 = 0x0 c1 = {cache_type = 3201937612, val_type = 3201937612, c = {avp_val = {n = 1076748296, s = {s = 0x402de008 "\001", len = -1093029644}, re = 0x402de008}, pval = {rs = { s = 0x402de008 "\001", len = -1093029644}, ri = 1085865828, flags = 86}}, i2s = "\000\000\000\000\254\177=\000\000\000\200\000\200\233n\000\350\304\016\000\200d"} s = {s = 0x1b5 <Address 0x1b5 out of bounds>, len = 2623776} srevp = {0x419f3210, 0x386f70} mod_f_params = {{type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NUMBER_ST, u = { number = 2, string = 0x2 <Address 0x2 out of bounds>, str = {s = 0x2 <Address 0x2 out of bounds>, len = 0}, data = 0x2, attr = 0x2, select = 0x2}}, { type = RVE_FREE_FIXUP_ST, u = {number = 0, string = 0x0, str = {s = 0x0, len = 3}, data = 0x0, attr = 0x0, select = 0x0}}, {type = MODFIXUP_ST, u = { number = 1077333124, string = 0x4036cc84 "X\314\066@ ", str = {s = 0x4036cc84 "X\314\066@ ", len = 3}, data = 0x4036cc84, attr = 0x4036cc84, select = 0x4036cc84}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}, {type = NOSUBTYPE, u = {number = 0, string = 0x0, str = {s = 0x0, len = 0}, data = 0x0, attr = 0x0, select = 0x0}}} __FUNCTION__ = "do_action" #23 0x00036ce8 in run_actions (h=0xbed9b4a0, a=0x4030fbc0, msg=0x40408d18) at actionc:1583 t = 0x403160fc ret = 1 mod = 0x0 ms = 0 __FUNCTION__ = "run_actions" #24 0x00037538 in run_top_route (a=0x4030fbc0, msg=0x40408d18, c=0x0) at actionc:1669 ctx = {rec_lev = 4, run_flags = 0, last_retcode = -1, jmp_env = {{__jmpbuf = {303571655, 0, 135544, 0, 0, 0, 1073991680, -1093028724, -1093028840, 223592, 0 <repeats 16 times>, 1610612752, 966492, 1138420, 1215756, 2623776, -1093028532, -1093028532, 1076748296, -1093028492, 1085865828, 1077859196, 0, 14, 8388608, 7250220, 966460, 1138388, 1215756, 4, 162, 0, 303571655, -1093028388, 626540, 4124784, 4122588, 3607920, 0, 1077859224, 303571655, 1077872804, 1076748296, 0, 5, 1164317944, 1164522740, -1093028324, 1077972248}, __mask_was_saved = 0, __saved_mask = {__val = {4848676, 1, 13, 3749280, 3201938908, 1, 13, 0, 1085944084, 0, 135544, 303571655, 0, 1073741825, 1077972248, 0, 303571655, 3201939020, 1691804, 0, 135544, 3751672, 4848758, 1077972268, 82, 1, 1077972248, 225, 1073741825, 1077972220, 0, 0}}}}} p = 0xbed9b4a0 ret = 135544 sfbk = 0 #25 0x0013ce80 in receive_msg ( buf=0x49fc24 "INFO sip:9144@101009144:5060;transport=TCP;alias=101009144:36841~2 SIP/20\r\nVia: SIP/20/UDP 101009336:5062;rport;branch=z9hG4bK897806495\r\nRoute: <sip:101009336:5060;nat=yes;lr=on>\r\nFrom: ", len=657, rcv_info=0xbed9b8b4) at receivec:216 msg = 0x40408d18 ctx = {rec_lev = 0, run_flags = 1, last_retcode = -1093028124, jmp_env = {{__jmpbuf = {-1093028084, 1094111756, 0, 1077352742, 2127, 5, 0, 1074750288, 1075464840, 1073835920, 1094553688, 1100326448, 76, 8403020, 1075499064, 1073991680, -1093027904, 1073913596, 1073993916, 1075465032, 0, 0, 1, 2127, 1074750344, 1074749440, 105499, 1075499832, 88616, 1, 19, 268896657, 1073994528, 0, -1093027928, 105499, 1074750344, -1093027836, -1093027860, 1073836664, -1093027928, 1073994436, 0, 1074750344, 1, 0, 1, 1073994088, 2623776, -12717463, 1073994528, 0, -1093027856, 104072, 1074750328, 0, 1073994528, 1073836664, 1073994088, 1073994436, 0, 1074750328, 1, 0}, __mask_was_saved = 1, __saved_mask = {__val = {1073994088, 3201939468, 626540, 1075499064, 1074749440, 0, 108658490, 1073994528, 0, 7714291, 135544, 1073994088, 0, 1074349248, 0, 1, 4427664, 0, 1073991680, 3201939580, 1073854768, 1074750344, 1, 1, 0, 0, 1075499064, 303571655, 0, 135544, 0, 0}}}}} ret = 2487808 inb = { s = 0x49fc24 "INFO sip:9144@101009144:5060;transport=TCP;alias=101009144:36841~2 SIP/20\r\nVia: SIP/20/UDP 101009336:5062;rport;branch=z9hG4bK897806495\r\nRoute: <sip:101009336:5060;nat=yes;lr=on>\r\nFrom: ", len = 657} __FUNCTION__ = "receive_msg" #26 0x00266708 in udp_rcv_loop () at udp_serverc:521 len = 657 buf = "INFO sip:9144@101009144:5060;transport=TCP;alias=101009144:36841~2 SIP/20\r\nVia: SIP/20/UDP 101009336:5062;rport;branch=z9hG4bK897806495\r\nRoute: <sip:101009336:5060;nat=yes;lr=on>\r\nFrom: " tmp = 0x0 from = 0x402fe830 fromlen = 16 ri = {src_ip = {af = 2, len = 4, u = {addrl = {610100234, 3201939668, 1935216, 1759989418}, addr32 = {610100234, 3201939668, 1935216, 1759989418}, addr16 = {25610, 9309, 47316, 48857, 34672, 29, 20138, 26855}, addr = "\nd]$\324\270\331\276p\207\035\000\252N\347h"}}, dst_ip = {af = 2, len = 4, u = {addrl = {610100234, 0, 0, 0}, addr32 = {610100234, 0, 0, 0}, addr16 = {25610, 9309, 0, 0, 0, 0, 0, 0}, addr = "\nd]$", '\000' <repeats 11 times>}}, src_port = 5062, dst_port = 5060, proto_reserved1 = 0, proto_reserved2 = 0, src_su = {s = {sa_family = 2, sa_data = "\023\306\nd]$\000\000\000\000\000\000\000"}, sin = {sin_family = 2, sin_port = 50707, sin_addr = {s_addr = 610100234}, sin_zero = "\000\000\000\000\000\000\000"}, sin6 = {sin6_family = 2, sin6_port = 50707, sin6_flowinfo = 610100234, 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 = 0}}, bind_address = 0x402fde78, proto = 1 '\001'} __FUNCTION__ = "udp_rcv_loop" #27 0x000c90a0 in main_loop () at mainc:1629 i = 0 pid = 0 si = 0x402fde78 si_desc = "udp receiver child=0 sock=101009336:5060 (101009336:5060)\000\300u1@h\t;\000 \236\060@\000\000\000\000x\021\002\000\024\260=@\000\000\000\000d\272\331\276\260\275'\000\230\331\070\000X\311\070\000\030\000\000\000\000\240[A\000\000\000\000\000\320\003@\244\303\230A" r = 1073991680 nrprocs = 1 __FUNCTION__ = "main_loop" #28 0x000d0830 in main (argc=5, argv=0xbed9bd04) at mainc:2581 cfg_stream = 0x4b5008 c = -1 r = 0 tmp = 0x4003dac4 "8c\017@\a" tmp_len = -1093026968 port = 1073836664 proto = -1093026900 options = 0x383880 ":f:cm:M:dVIhEeb:l:L:n:vKrRDTN:W:w:t:u:g:P:G:SQ:O:a:A:" ret = -1 seed = 629055291 rfd = 216 debug_save = 0 debug_flag = 0 dont_fork_cnt = 0 n_lst = 0x0 p = 0x5 <Address 0x5 out of bounds> __FUNCTION__ = "main" --------------------------------------------------------------------------------------------------------- It seems the socket got error (uncertain) Does anyone have the similar experience? Thanks --- Reply to this email directly or view it on GitHub: https://github.com/kamailio/kamailio/issues/466

2 11

[kamailio] [4.2.6] kamailio does not work when Recv-Q is high... (#510)
by BroWater 14 Sep '16

14 Sep '16

Steps: (1) 9 users and 1 mcu registered the server (2) All 9 users connect to the mcu through the server (3) For a while, some users showed registration fail, we found Kamailio does not respond to any further SIP message. I checked this using `netstat -apn` and it showed: ``` Active Internet connections (servers and established) Proto Recv-Q Send-Q Local Address Foreign Address State PID/Program name tcp 0 0 10.100.92.42:5060 0.0.0.0:* LISTEN 9384/kamailio tcp 0 0 10.100.92.42:5061 0.0.0.0:* LISTEN 9384/kamailio tcp 48963 0 10.100.92.42:5060 10.100.92.42:42177 ESTABLISHED 9375/kamailio tcp 29621 0 10.100.92.42:5060 10.100.92.40:34392 ESTABLISHED 9375/kamailio tcp 1617 0 10.100.92.42:43997 10.100.92.42:5062 ESTABLISHED 9375/kamailio tcp 2506 0 10.100.92.42:5060 10.100.92.68:37386 ESTABLISHED 9383/kamailio udp 0 0 127.0.0.1:50180 127.0.0.1:7722 ESTABLISHED 9384/kamailio udp 0 0 127.0.0.1:47125 127.0.0.1:7722 ESTABLISHED 9378/kamailio udp 0 0 127.0.0.1:55318 127.0.0.1:7722 ESTABLISHED 9375/kamailio udp 0 0 127.0.0.1:44595 127.0.0.1:7722 ESTABLISHED 9382/kamailio udp 0 0 127.0.0.1:41045 127.0.0.1:7722 ESTABLISHED 9383/kamailio udp 0 0 127.0.0.1:52901 127.0.0.1:7722 ESTABLISHED 9380/kamailio udp 0 0 127.0.0.1:39078 127.0.0.1:7722 ESTABLISHED 9376/kamailio udp 0 0 127.0.0.1:36548 127.0.0.1:7722 ESTABLISHED 9377/kamailio udp 0 0 127.0.0.1:55005 127.0.0.1:7722 ESTABLISHED 9374/kamailio udp 0 0 127.0.0.1:53049 127.0.0.1:7722 ESTABLISHED 9381/kamailio udp 0 0 127.0.0.1:44358 127.0.0.1:7722 ESTABLISHED 9374/kamailio udp 0 0 127.0.0.1:60253 127.0.0.1:7722 ESTABLISHED 9379/kamailio udp 0 0 10.100.92.42:5060 0.0.0.0:* 9374/kamailio udp 0 0 ::ffff:127.0.0.1:7722 :::* 9354/rtpengine raw 0 0 0.0.0.0:255 0.0.0.0:* 255 9374/kamailio ``` And I attached the gdb to the those processed which Recv-Q value were high, it showed: PID [9375] ``` #0 0x400a7450 in recvfrom () from /lib/libpthread.so.0 No symbol table info available. #1 0x00265848 in udp_rcv_loop () at udp_server.c:446 len = 472 buf = "REGISTER sip:10.100.92.42:5060 SIP/2.0\r\nVia: SIP/2.0/UDP 10.100.91.13:5060;rport;branch=z9hG4bK649620372\r\nFrom: <sip:DEMOROOM_2@10.100.92.42>;tag=658334621\r\nTo: <sip:DEMOROOM_2@10.100.92.42>\r\nCall-ID:"... tmp = 0x49fbfc "10.100.92.43" from = 0x402d5b24 fromlen = 16 ri = {src_ip = {af = 2, len = 4, u = {addrl = {224093194, 3200776404, 1935216, 1734536862}, addr32 = {224093194, 3200776404, 1935216, 1734536862}, addr16 = {25610, 3419, 63700, 48839, 34672, 29, 61086, 26466}, addr = "\nd[\r\324\370\307\276p\207\035\000\236\356bg"}}, dst_ip = {af = 2, len = 4, u = {addrl = {710697994, 0, 0, 0}, addr32 = {710697994, 0, 0, 0}, addr16 = {25610, 10844, 0, 0, 0, 0, 0, 0}, addr = "\nd\\*", '\000' <repeats 11 times>}}, src_port = 5060, dst_port = 5060, proto_reserved1 = 0, proto_reserved2 = 0, src_su = {s = {sa_family = 2, sa_data = "\023\304\nd[\r\000\000\000\000\000\000\000"}, sin = { sin_family = 2, sin_port = 50195, sin_addr = {s_addr = 224093194}, sin_zero = "\000\000\000\000\000\000\000"}, sin6 = {sin6_family = 2, sin6_port = 50195, sin6_flowinfo = 224093194, 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 = 0}}, bind_address = 0x40261e14, proto = 1 '\001'} __FUNCTION__ = "udp_rcv_loop" #2 0x000c90a0 in main_loop () at main.c:1629 i = 0 pid = 0 si = 0x40261e14 si_desc = "udp receiver child=0 sock=10.100.92.42:5060\000\244\372\307\276\304y2A\000\000,\000\000\000X\000 \000\062@ \313'@h\t;\000\230\325&@\000\000\000\000x\021\002\000\060K1@\000\000\000\000d\372\307\276\260\275'\000\230\331\070\000X\311\070\000\030\000\000\000\000PVA\000\000\000\000\000\000\a@Lu\223A" r = 1074200576 nrprocs = 1 __FUNCTION__ = "main_loop" #3 0x000d0830 in main (argc=5, argv=0xbec7fd04) at main.c:2581 cfg_stream = 0x4b5008 c = -1 r = 0 tmp = 0x40070ac4 "P\002\006@\a" tmp_len = -1094190232 port = 1074045560 proto = -1094190164 options = 0x383880 ":f:cm:M:dVIhEeb:l:L:n:vKrRDTN:W:w:t:u:g:P:G:SQ:O:a:A:" ret = -1 seed = 3985271057 rfd = 206 debug_save = 0 debug_flag = 0 dont_fork_cnt = 0 n_lst = 0x0 p = 0x5 <Address 0x5 out of bounds> __FUNCTION__ = "main" ``` PID [9383] ``` #0 0x400a6a04 in __lll_lock_wait () from /lib/libpthread.so.0 #1 0x400a10b8 in pthread_mutex_lock () from /lib/libpthread.so.0 #2 0x002145b4 in tcpconn_do_send (fd=21, c=0x41969534, buf=0x402cbcb0 "SIP/2.0 200 Keepalive\r\nVia: SIP/2.0/TCP 10.100.92.42:5062;rport=42177;branch=z9hG4bK416855936;received=10.100.92.42\r\nFrom: <sip:10.100.92.42:42177>;tag=1996784611\r\nTo: <sip:10.100.92.42:5060>;tag=e926"..., len=340, send_flags=..., resp=0xbec7daf8, locked=0) at tcp_main.c:2520 #3 0x002130f0 in tcpconn_send_put (c=0x41969534, buf=0x402cbcb0 "SIP/2.0 200 Keepalive\r\nVia: SIP/2.0/TCP 10.100.92.42:5062;rport=42177;branch=z9hG4bK416855936;received=10.100.92.42\r\nFrom: <sip:10.100.92.42:42177>;tag=1996784611\r\nTo: <sip:10.100.92.42:5060>;tag=e926"..., len=340, send_flags=...) at tcp_main.c:2377 #4 0x002105c0 in tcp_send (dst=0xbec7e38c, from=0x0, buf=0x402cbcb0 "SIP/2.0 200 Keepalive\r\nVia: SIP/2.0/TCP 10.100.92.42:5062;rport=42177;branch=z9hG4bK416855936;received=10.100.92.42\r\nFrom: <sip:10.100.92.42:42177>;tag=1996784611\r\nTo: <sip:10.100.92.42:5060>;tag=e926"..., len=340) at tcp_main.c:2133 #5 0x40e33164 in msg_send (dst=0xbec7e38c, buf=0x402cbcb0 "SIP/2.0 200 Keepalive\r\nVia: SIP/2.0/TCP 10.100.92.42:5062;rport=42177;branch=z9hG4bK416855936;received=10.100.92.42\r\nFrom: <sip:10.100.92.42:42177>;tag=1996784611\r\nTo: <sip:10.100.92.42:5060>;tag=e926"..., len=340) at ../../forward.h:225 #6 0x40e362e8 in sl_reply_helper (msg=0x40342814, code=200, reason=0x402e1d6c "Keepalive", tag=0x0) at sl_funcs.c:224 #7 0x40e373e0 in sl_send_reply (msg=0x40342814, code=200, reason=0x402e1d6c "Keepalive") at sl_funcs.c:327 #8 0x40e2b30c in w_sl_send_reply (msg=0x40342814, p1=0x40282108 "\244\324(@\001", p2=0x40282140 "d\320(@ ") at sl.c:236 #9 0x00029b90 in do_action (h=0xbec7f110, a=0x4028cf34, msg=0x40342814) at action.c:1100 #10 0x00036ce8 in run_actions (h=0xbec7f110, a=0x4028cf34, msg=0x40342814) at action.c:1583 #11 0x00029a2c in do_action (h=0xbec7f110, a=0x4028d120, msg=0x40342814) at action.c:1079 #12 0x00036ce8 in run_actions (h=0xbec7f110, a=0x40288ed8, msg=0x40342814) at action.c:1583 #13 0x000263ac in do_action (h=0xbec7f110, a=0x40279db8, msg=0x40342814) at action.c:712 #14 0x00036ce8 in run_actions (h=0xbec7f110, a=0x4027321c, msg=0x40342814) at action.c:1583 #15 0x00037538 in run_top_route (a=0x4027321c, msg=0x40342814, c=0x0) at action.c:1669 #16 0x0013ce80 in receive_msg ( buf=0x41969714 "OPTIONS sip:10.100.92.42:5060 SIP/2.0\r\nVia: SIP/2.0/TCP 10.100.92.42:5062;rport;branch=z9hG4bK416855936\r\nFrom: <sip:10.100.92.42:42177>;tag=1996784611\r\nTo: <sip:10.100.92.42:5060>\r\nCall-ID: 2059319404"..., len=404, rcv_info=0x4196955c) at receive.c:216 #17 0x00248fbc in receive_tcp_msg ( tcpbuf=0x41969714 "OPTIONS sip:10.100.92.42:5060 SIP/2.0\r\nVia: SIP/2.0/TCP 10.100.92.42:5062;rport;branch=z9hG4bK416855936\r\nFrom: <sip:10.100.92.42:42177>;tag=1996784611\r\nTo: <sip:10.100.92.42:5060>\r\nCall-ID: 2059319404"..., len=404, rcv_info=0x4196955c, con=0x41969534) at tcp_read.c:1230 #18 0x0024c484 in tcp_read_req (con=0x41969534, bytes_read=0xbec7f714, read_flags=0xbec7f70c) at tcp_read.c:1431 #19 0x0024fdd8 in handle_io (fm=0x403321ac, events=1, idx=-1) at tcp_read.c:1655 #20 0x0023f814 in io_wait_loop_epoll (h=0x47d90c, t=2, repeat=0) at io_wait.h:1073 #21 0x00250fc8 in tcp_receive_loop (unix_sock=22) at tcp_read.c:1764 #22 0x00234674 in tcp_init_children () at tcp_main.c:4879 #23 0x000c9dec in main_loop () at main.c:1714 #24 0x000d0830 in main (argc=5, argv=0xbec7fd04) at main.c:2581 ``` In process 9375, I found it got stuck in recvfrom () (udp_server.c:446), and the code is: `len=recvfrom(bind_address->socket, buf, BUF_SIZE, 0, &from->s,&fromlen);` It seems operate using blocking mode instead of a non-blocking one, why??? Or maybe I miss a packet-check function like select() or poll()?? Thanks in advance. :) --- Reply to this email directly or view it on GitHub: https://github.com/kamailio/kamailio/issues/510

2 9

[kamailio/kamailio] textops: get_body_part doesn't detect multipart headers ending (#564)
by foucse 13 Sep '16

13 Sep '16

When I use get_body_part on a multipart body, it doesn't detect properly the ending of multipart headers: For instance in: ``` --vvemeemm0wqr7ayc5h367f3v8e66mc9t Content-Type: application/sdp Content-Length: 479 v=0 o=- 3669362310 3669362310 IN IP4 192.168.2.4 [...] ``` "Content-Length: 479" is taken into get_body_part("application/sdp", "$var(sdp)"); I will try to provide more details later. --- You are receiving this because you are subscribed to this thread. Reply to this email directly or view it on GitHub: https://github.com/kamailio/kamailio/issues/564

4 7

[kamailio/kamailio] Kamailio 4.4) sipcapture_module: ERROR: parse_msg: message=<HEP3#003�> (#599)
by goseeped 12 Sep '16

12 Sep '16

The sipcapture module works great when you send hepv3 packets over the UDP transport however if kamailio start listening those hepv3 packtes on TCP and sending those hepv3 on TCP it will concern about it. **This is what Kamilio receives over TCP.** > T 52.10.155.177:47283 -> 172.19.8.21:9060 [AP] > HEP3.0................... > ......... > ...........[............. > W*y6... > . > ..h...... > .................OPTIONS sip:edge.rarevase.com;transport=tcp SIP/2.0. > Via: SIP/2.0/TCP 172.19.16.130:53083;rport;branch=z9hG4bKPj66df463f-ca4b-4f98-ba17-722fe3fc4a92;alias. > From: <sip:asterisk@172.19.16.130>;tag=86ebab1d-eb4e-4986-898d-c7392b6b747b. > To: <sip:edge.rarevase.com>. > Contact: <sip:asterisk@172.19.16.130:53083;transport=TCP>. > Call-ID: ed24ab3c-4f42-4a9d-8e2d-9a3acd5b5b70. > CSeq: 3809 OPTIONS. > Max-Forwards: 70. > User-Agent: Asterisk PBX 13.8.0. > Content-Length: 0. > . > > ## > T 52.10.155.177:47283 -> 172.19.8.21:9060 [AP] > HEP3.\................... > ......... > ...................[..... > W*y6... > . > ..|...... > .................SIP/2.0 200 OK. > Via: SIP/2.0/TCP 172.19.16.130:53083;rport=53083;received=172.19.16.130;branch=z9hG4bKPj66df463f-ca4b-4f98-ba17-722fe3fc4a92;alias. > From: <sip:asterisk@172.19.16.130>;tag=86ebab1d-eb4e-4986-898d-c7392b6b747b. > To: <sip:edge.rarevase.com>;tag=24voZr. > Call-ID: ed24ab3c-4f42-4a9d-8e2d-9a3acd5b5b70. > CSeq: 3809 OPTIONS. > Max-Forwards: 70. > Content-Length: 0. > Supported: path,gruu,outbound. > Accept: */*. > Allow: INVITE,ACK,CANCEL,BYE,OPTIONS,INFO,UPDATE,SUBSCRIBE,NOTIFY,REFER,MESSAGE,REGISTER. > . > **This are the logs on the Kamailio.** `May 4 22:44:05 ip-172-19-8-21 /usr/sbin/kamailio[19285]: INFO: <core> [parser/parse_fline.c:144]: parse_first_line(): ERROR:parse_first_line: method not followed by SP May 4 22:44:05 ip-172-19-8-21 /usr/sbin/kamailio[19285]: ERROR: <core> [parser/parse_fline.c:257]: parse_first_line(): parse_first_line: bad message (offset: 0) May 4 22:44:05 ip-172-19-8-21 /usr/sbin/kamailio[19285]: DEBUG: <core> [parser/msg_parser.c:604]: parse_msg(): parse_msg: invalid message May 4 22:44:05 ip-172-19-8-21 /usr/sbin/kamailio[19285]: ERROR: <core> [parser/msg_parser.c:690]: parse_msg(): ERROR: parse_msg: message=<HEP3#003<98>> May 4 22:44:05 ip-172-19-8-21 /usr/sbin/kamailio[19285]: ERROR: <core> [receive.c:173]: receive_msg(): core parsing of SIP message failed (52.10.155.177:59607/2)` --- You are receiving this because you are subscribed to this thread. Reply to this email directly or view it on GitHub: https://github.com/kamailio/kamailio/issues/599

4 9

[kamailio] uac module (uac_req_send, register) doesn't do failover (#210)
by Alex 30 Aug '16

30 Aug '16

Requests send with uac module's functions like uac_req_send() and remote registrations use the TM module, but don't actually do (DNS) failover when a destination is unreachable or sends a 503. In the tm's uac.c, t_uac_prepare() function, i can already see that the dns handle is stored in a throwaway variable instead of in the transaction, but fixing the issue isn't as simple as just storing it in the transaction (print_uac_request_from_buf() needs a uas in the transaction). Due to github not supporting attachments to issues, the sample config and debug log are inline.... :( DNS entry: ``` $ host -t SRV _sip._udp.failover.test.speakup.nl _sip._udp.failover.test.speakup.nl has SRV record 10 0 1111 try1.test.speakup.nl. _sip._udp.failover.test.speakup.nl has SRV record 100 0 2222 try2.test.speakup.nl. ``` Log snippet: ```syslog Jun 15 10:00:03 rio UACFailover[18178]: INFO: <script>: Sending OPTIONS request to sip:failover.test.speakup.nl Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: tm [uac.c:249]: t_uac_prepare(): DEBUG:tm:t_uac: next_hop=<sip:failover.test.speakup.nl> Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [dns_cache.c:537]: _dns_hash_find(): (_sip._udp.failover.test.speakup.nl(34), 33), h=825 Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [resolve.c:937]: get_record(): skipping 8 NS (p=0x9ea284, end=0x9ea3e9) Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [resolve.c:952]: get_record(): parsing 9 ARs (p=0x9ea335, end=0x9ea3e9) Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [dns_cache.c:1741]: dns_get_related(): (0x7f225233eb38 (_sip._udp.failover.test.speakup.nl, 33), 33, *0x7f2257baf2b8) (0) Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [dns_cache.c:840]: dns_cache_add_unsafe(): adding _sip._udp.failover.test.speakup.nl(34) 33 (flags=0) at 825 Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [dns_cache.c:840]: dns_cache_add_unsafe(): adding try1.test.speakup.nl(20) 1 (flags=0) at 310 Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [dns_cache.c:840]: dns_cache_add_unsafe(): adding try2.test.speakup.nl(20) 1 (flags=0) at 307 Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [dns_cache.c:2336]: dns_srv_get_nxt_rr(): (0x7f225233eb38, 0, 0, 1597643831): selected 0/1 in grp. 0 (rand_w=0, rr=0x7f225233eba0 rd=0x7f225233ebb8 p=10 w=0 rsum=0) Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [dns_cache.c:537]: _dns_hash_find(): (try1.test.speakup.nl(20), 1), h=310 Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [dns_cache.c:2926]: dns_a_resolve(): (try1.test.speakup.nl, 0) returning 0 Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [dns_cache.c:3169]: dns_srv_resolve_ip(): ("_sip._udp.failover.test.speakup.nl", 0, 0), ret=0, ip=192.168.1.245 Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [dns_cache.c:3260]: dns_srv_sip_resolve(): (failover.test.speakup.nl, 0, 0), srv0, ret=0 Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: tm [uac.c:150]: dlg2hash(): DEBUG: dlg2hash: 54501 Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: tm [uac.c:351]: t_uac_prepare(): executing event_route[tm:local-request] Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [parser/msg_parser.c:606]: parse_msg(): SIP Request: Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [parser/msg_parser.c:608]: parse_msg(): method: <OPTIONS> Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [parser/msg_parser.c:610]: parse_msg(): uri: <sip:failover.test.speakup.nl> Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [parser/msg_parser.c:612]: parse_msg(): version: <SIP/2.0> Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [parser/parse_via.c:1254]: parse_via_param(): Found param type 232, <branch> = <z9hG4bK5e4d.47adbbf5000000000000000000000000.0>; state=16 Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [parser/parse_via.c:2642]: parse_via(): end of header reached, state=5 Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [parser/msg_parser.c:496]: parse_headers(): parse_headers: Via found, flags=2 Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [parser/msg_parser.c:498]: parse_headers(): parse_headers: this is the first via Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [parser/parse_addr_spec.c:894]: parse_addr_spec(): end of header reached, state=10 Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [parser/msg_parser.c:173]: get_hdr_field(): DEBUG: get_hdr_field: <To> [22]; uri=[sip:to.example.com] Jun 15 10:00:03 rio UACFailover[18178]: [97B blob data] Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [parser/msg_parser.c:153]: get_hdr_field(): get_hdr_field: cseq <CSeq>: <10> <OPTIONS> Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: pv [pv_core.c:376]: pv_get_xto_attr(): no Tag parameter Jun 15 10:00:03 rio UACFailover[18178]: INFO: <script>: [udp:172.28.4.128:6789] [10 OPTIONS] Request (cid: 6cd531e47cc63e20-18178(a)172.28.4.128 Branch: -1 ToTag: <null> len:382) To <sip:failover.test.speakup.nl> via <sip:failover.test.speakup.nl> Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil) Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil) Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil) Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil) Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil) Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [usr_avp.c:631]: destroy_avp_list(): destroying list (nil) Jun 15 10:00:03 rio UACFailover[18178]: DEBUG: <core> [xavp.c:446]: xavp_destroy_list(): destroying xavp list (nil) Jun 15 10:00:05 rio UACFailover[18176]: DEBUG: tm [t_reply.c:1230]: t_should_relay_response(): ->>>>>>>>> T_code=0, new_code=408 Jun 15 10:00:05 rio UACFailover[18176]: WARNING: tm [t_reply.c:957]: run_failure_handlers(): Warning: run_failure_handlers: no UAC support (1, 0) Jun 15 10:00:05 rio UACFailover[18176]: DEBUG: tm [t_reply.c:2016]: local_reply(): DEBUG: local_reply: branch=0, save=0, winner=0 Jun 15 10:00:05 rio UACFailover[18176]: DEBUG: tm [t_reply.c:2053]: local_reply(): DEBUG: local transaction completed ``` Sample config: ```python #------------------ # Flags #------------------ debug=3 memdbg=5 mem_summary=5 #fork=no # This option should not be present to enable forking but disable daemonize, also -D commandline parameter is needed log_stderror=no sip_warning=no listen=172.28.4.128 port=6789 children=2 shm_mem_size=64 log_name="UACFailover" check_via=no # (cmd. line: -v) dns=no # (cmd. line: -r) rev_dns=no # (cmd. line: -R) dns_use_search_list=no use_dns_failover=yes dns_srv_lb=yes disable_tcp=yes mpath="/usr/lib/x86_64-linux-gnu/kamailio/modules/" loadmodule "pv.so" loadmodule "tm.so" loadmodule "tmx.so" loadmodule "sl.so" loadmodule "xlog.so" loadmodule "rr.so" loadmodule "uac.so" loadmodule "rtimer.so" # ----------------------------------------------------------------- # Module settings # ----------------------------------------------------------------- modparam("pv", "varset", "server=s:LOGNAME") modparam("tm", "auto_inv_100", 0) # Time until provisional response (eg "100 Trying") is received modparam("tm", "fr_timer", 2000) # Time to await final response on INVITE per branch (eg per branch ring time) modparam("tm", "fr_inv_timer", 10000) # Time to await final response on INVITE (eg ring time) modparam("tm", "max_inv_lifetime", 20000) modparam("tm", "restart_fr_on_each_reply", 0) modparam("tm", "failure_reply_mode", 3) modparam("rtimer", "timer", "name=uac;interval=10;mode=1;") modparam("rtimer", "exec", "timer=uac;route=TIMER") route { xlog("L_NOTICE", "[$pr:$si:$sp] [$cs $rm] Request. (cid: $ci <$fu> => <$ru> len: $ml)"); drop(); } event_route[tm:local-request] { xlog("L_INFO", " [$pr:$si:$sp] [$cs $rm] Request (cid: $ci Branch: $T_branch_idx ToTag: $tt len:$ml) To <$ru> via <$du>"); } onreply_route { xlog("L_INFO", " [$pr:$si:$sp] [$cs $rm] Reply (cid: $ci Branch: $T_branch_idx Status: $rs $rr ToTag: $tt len:$ml)"); } route[TIMER] { if not $var(done) == 1 { $var(done) = 1; $uac_req(method) = "OPTIONS"; $uac_req(ruri) = "sip:failover.test.speakup.nl"; $uac_req(furi) = "sip:from.example.com"; $uac_req(turi) = "sip:to.example.com"; xlog("L_INFO", "Sending $uac_req(method) request to $uac_req(ruri)"); uac_req_send(); } } ``` --- Reply to this email directly or view it on GitHub: https://github.com/kamailio/kamailio/issues/210

2 3

git:master:b7c588df: tm: store last received response code before running onreply_route
by Daniel-Constantin Mierla 02 Aug '16

02 Aug '16

Module: kamailio Branch: master Commit: b7c588dff06030a82f305b210573be5bbc961cec URL: https://github.com/kamailio/kamailio/commit/b7c588dff06030a82f305b210573be5… Author: Daniel-Constantin Mierla <miconda(a)gmail.com> Committer: Daniel-Constantin Mierla <miconda(a)gmail.com> Date: 2015-09-07T15:56:45+02:00 tm: store last received response code before running onreply_route - otherwise an innapropriate cancel can happen if the current branch got before an 1xx response, and the script writer enforces another reply code with t_reply() - reported by Thomas Sevestre, GH#315 --- Modified: modules/tm/t_reply.c --- Diff: https://github.com/kamailio/kamailio/commit/b7c588dff06030a82f305b210573be5… Patch: https://github.com/kamailio/kamailio/commit/b7c588dff06030a82f305b210573be5… --- diff --git a/modules/tm/t_reply.c b/modules/tm/t_reply.c index b2e6e53..8da3205 100644 --- a/modules/tm/t_reply.c +++ b/modules/tm/t_reply.c @@ -2286,10 +2286,21 @@ int reply_received( struct sip_msg *p_msg ) backup_xavps = xavp_set_list(&t->xavps_list); #endif setbflagsval(0, uac->branch_flags); + if(msg_status>last_uac_status) { + /* current response (msg) status is higher that the last received + * on the same branch - set it temporarily so functions in onreply_route + * can access it (e.g., avoid sending CANCEL by forcing another t_relply() + * in onreply_route when a negative sip response was received) */ + uac->last_received = msg_status; + } + /* Pre- and post-script callbacks have already * been executed by the core. (Miklos) */ run_top_route(onreply_rt.rlist[onreply_route], p_msg, &ctx); + + /* restore brach last_received as before executing onreply_route */ + uac->last_received = last_uac_status; /* transfer current message context back to t */ if (t->uas.request) t->uas.request->flags=p_msg->flags; getbflagsval(0, &uac->branch_flags);

2 1

[kamailio] Module:sca Line seize does not release after some 'bye's (#341)
by Kevin Scott Adams 07 Jul '16

07 Jul '16

I have a situation that I can't get my head around. Every so often I have a SCA seized and I need to manually release it. Here is the log of the sca and bye from the event logs. messages-20150920:Sep 18 14:35:28 sip-registrar /usr/sbin/kamailio[7608]: ERROR: sca [sca_call_info.c:1580]: sca_call_info_bye_handler(): sca_call_info_bye_handler: sip:Mindfield@kamailio.newgarllc.com dialog leg 96b9ad37-9a7fa462-15c35d3(a)192.168.1.117;1c389191866 is not active messages-20150920:Sep 18 14:35:28 sip-registrar /usr/sbin/kamailio[7610]: NOTICE: acc [acc.c:317]: acc_log_request(): ACC: transaction answered: timestamp=1442601328;method=BYE;from_tag=76C3EC1F-114D759A;to_tag=1c389191866;call_id=96b9ad37-9a7fa462-15c35d3(a)192.168.1.117;code=200;reason=OK;src_user=Mindfield;src_domain=kamailio.newgarllc.com;src_ip=192.168.1.40;dst_ouser=Mindfield;dst_user=Mindfield;dst_domain=192.168.1.117 And the kamcmd showing the seize line (in this case both are seized) sip:Mindfield@kamailio.newgarllc.com 1 active 1442601278 sip:Mindfield@192.168.1.117 sip:1030@192.168.1.40:5060 96b9ad37-9a7fa462-15c35d3(a)192.168.1.117 76C3EC1F-114D759A 1c389191866 I am running Kamailio 4.2.6. The phones are Polycom VVX 310/410 running 5.3.1. And the PSTN gateway is an Audiocodes Mediant 1000 running 6.60A.292.001. The call volume is light so I don't think there is a lot of traffic but there is about 16 phones one SCA. It is not happening all time. Could be a couple days that nothing happens and then there could be a couple days that it happens multiple times a day. I can't find a common element that would be causing this unless the 'bye' is closing the call before the SCA has a chance to do something with it. Thanks Kev --- Reply to this email directly or view it on GitHub: https://github.com/kamailio/kamailio/issues/341

4 18

[kamailio/kamailio] [Branch 4.4] Cannot save location after resuming a transaction that has been paused by avapi_async_relay (#622)
by Minh PHAN 06 Jul '16

06 Jul '16

Console log: ``` 9(27) INFO: <script>: preparing to resume transaction for processing: 6118 / 1144728330 / resume_auth 9(27) ERROR: <script>: Saving location 9(27) ERROR: <core> [db.c:452]: db_use_table(): invalid parameter value 9(27) ERROR: usrloc [ucontact.c:1137]: db_update_ucontact_ruid(): sql use_table failed 9(27) ERROR: usrloc [ucontact.c:1658]: update_contact_db(): failed to update database 9(27) ERROR: registrar [save.c:776]: update_contacts(): failed to update contact ``` Config script snipset: ``` route[authenticate] { if (!$aU) { xlog("REGISTER without aU = $aU"); www_challenge("$fd", "0"); exit; } evapi_async_relay("{'tindex': $T(id_index), 'tlabel': $T(id_label), 'method': 'authenticate', 'route': 'resume_auth'," "'data': { 'si': '$si', 'fU': '$fU', 'fd': '$fd', 'rU': '$rU', 'aU': '$aU', 'rd': '$rd' }" "}" ); xlog("L_INFO", "suspended transaction: $T(id_index) / $T(id_label)\n"); exit; } route[resume_auth] { xlog("Saving location\n"); if (!save("location")) { sl_reply_error(); } exit; } event_route[evapi:message-received] { xlog("received [$evapi(msg)] from $evapi(srcaddr):$evapi(srcport)\n"); jansson_get("tindex", "$evapi(msg)", "$var(tindex)"); jansson_get("tlabel", "$evapi(msg)", "$var(tlabel)"); jansson_get("route", "$evapi(msg)", "$var(next_route)"); xlog("L_INFO", "preparing to resume transaction for processing: $var(tindex) / $var(tlabel) / $var(next_route)\n"); t_continue("$var(tindex)", "$var(tlabel)", "$var(next_route)"); } ``` --- You are receiving this because you are subscribed to this thread. Reply to this email directly or view it on GitHub: https://github.com/kamailio/kamailio/issues/622

3 16

[kamailio/kamailio] Using registered() in event_route[usrloc:contact-expired] causes Kamailio to hang (#577)
by Olle E. Johansson 27 Jun '16

27 Jun '16

In the contact-expired event route I want to check if the expired AOR is registered elsewhere, by checking replicated location tables like "location-peer". Using the registered("location-peer", "<aor>") function causes Kamailio to go to sleep and not respond to rpc commands. --- You are receiving this because you are subscribed to this thread. Reply to this email directly or view it on GitHub: https://github.com/kamailio/kamailio/issues/577

2 6

← Newer
1
2
3
4
5
6
7
...
35
Older →

Jump to page:

2025

2024

2023

2022

2021

2020

2019

2018

2017

2016

2015

2014

2013

2012

2011

2010

2009

2008

sr-dev May 2016