<div dir="ltr"><div>Hi,</div><div><br></div><div>Any ideas regarding "t_append_branches(): failure to add branches (-1)"?</div><div><br></div><div>Is there a way somehow to dump what ts_append handover towards tm? I think if I would be able to see this I will be able to understand what is wrong. I tried tm:local-request and failure route and branch route, but these routes are not executed when this error happens.<br></div><div><br></div><div>Maybe the issue is that the TLS connection is established between Kamailio and UAC what is in front my Register and this Register kamailio just tries to connect directly towards UAC and it fails? At least this is my idea why this might fail.<br></div><div><br clear="all"></div><div dir="ltr"><div><div dir="ltr" class="gmail_signature" data-smartmail="gmail_signature"><div dir="ltr">Jurijs<br></div></div></div><br></div><br><div class="gmail_quote"><div dir="ltr" class="gmail_attr">On Thu, Oct 29, 2020 at 8:38 AM Jurijs Ivolga <<a href="mailto:jurijs.ivolga@gmail.com">jurijs.ivolga@gmail.com</a>> wrote:<br></div><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex"><div dir="ltr">
<div>Hi
Federico,</div><div><br></div><div>Indeed I had a messed up config at that point. I cleaned it up, but still had the same problem.</div><div><br></div><div>Full log in attachment.</div><div><br></div><div>Here is some part of it:</div><div><br></div><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex"><div><font size="1">45(51) DEBUG: {1 21 REGISTER 6z~FzexPro} tsilo [ts_append.c:72]: ts_append(): transaction 16864:783220347 found for <a href="mailto:sip%3A1443452187102-0af7c6035717-0001@voipstaging.myappapp.net" target="_blank">sip:1443452187102-0af7c6035717-0001@voipstaging.myappapp.net</a>, going to append branches<br>45(51) DEBUG: {1 21 REGISTER 6z~FzexPro} tm [t_lookup.c:1612]: t_lookup_ident_filter(): transaction found<br>45(51) DEBUG: {1 21 REGISTER 6z~FzexPro} registrar [lookup.c:306]: lookup_helper(): contact for [1443452187102-0af7c6035717-0001] found by address<br>45(51)
DEBUG: {1 21 REGISTER 6z~FzexPro} tm [t_append_branches.c:77]:
t_append_branches(): transaction 16864:783220347 in status 180<br>45(51) DEBUG: {1 21 REGISTER 6z~FzexPro} tm [t_append_branches.c:99]: t_append_branches(): Call <a href="mailto:3ed4a6c3051ea46b50487a0d1b5b25ec@10.10.0.0" target="_blank">3ed4a6c3051ea46b50487a0d1b5b25ec@10.10.0.0</a>: 1 (0) outgoing branches<br>45(51) DEBUG: {1 21 REGISTER 6z~FzexPro} tm [t_append_branches.c:163]: t_append_branches(): Call <a href="mailto:3ed4a6c3051ea46b50487a0d1b5b25ec@10.10.0.0" target="_blank">3ed4a6c3051ea46b50487a0d1b5b25ec@10.10.0.0</a>: 1 (0) outgoing branches after clear_branches()<br>45(51) ERROR: {1 21 REGISTER 6z~FzexPro} tm [t_append_branches.c:172]: <b>t_append_branches(): failure to add branches (-1)</b><br>45(51) INFO: {1 21 REGISTER 6z~FzexPro} <script>: tsilo appending branch <a href="mailto:sip%3A1443452187102-0af7c6035717-0001@voipstaging.myappapp.net" target="_blank">sip:1443452187102-0af7c6035717-0001@voipstaging.myappapp.net</a></font></div></blockquote><div><br></div><div>Here Kamailio snippets of config:</div><div>...........................................................<br></div><div style="margin-left:40px"><font size="1">route[CONTINUE] {<br> if (!is_method("REGISTER"))<br> return;<br> $var(pjoin) = 0;<br> lock("$tU");<br> $var(pjoin) = $sht(pmap=>join::$tU);<br> $var(pstored) = $sht(pmap=>stored::$tU);<br> xlog("L_INFO", "===== Stored 1 not stored 0 $var(pstored) [$sht(pmap=>stored::$tU)] \n");<br> $sht(pmap=>join::$tU) = $null;<br> unlock("$tU");<br> if($var(pjoin)==0) {<br> if ($var(pstored)) {<br> if($expires(min)>0) {<br> ts_append("location", "sip:$<a href="mailto:tU@voipstaging.onoffapp.net" target="_blank">tU@voipstaging.onoffapp.net</a>");<br> xlog("L_INFO","tsilo appending branch $tu \n");<br> }<br> }<br> return;<br> }<br> $var(id_index) = $(var(pjoin){s.select,0,:}{<a href="http://s.int" target="_blank">s.int</a>});<br> $var(id_label) = $(var(pjoin){s.select,1,:}{<a href="http://s.int" target="_blank">s.int</a>});<br> xlog("L_INFO", "===== resuming suspended trasaction [$var(id_index):$var(id_label)] $tU ($var(pjoin)) \n");<br> t_continue("$var(id_index)", "$var(id_label)", "LOCATION");<br>}</font><br></div><div><font size="1">
</font><div>...........................................................<br></div>
</div><div><font size="1"> if (is_method("INVITE")) {<br> ts_store();<br> $sht(pmap=>stored::$rU) = 1;<br> xlog("L_ERR" ,"stored transaction [$T(id_index):$T(id_label)] $fU => $rU\n");<br> }<br></font></div><div>
<div>...........................................................<font color="#888888"><br></font></div><div><font color="#888888"><br></font></div></div>
<div><div dir="ltr"><div dir="ltr">Jurijs<br></div></div></div><br></div><br><div class="gmail_quote"><div dir="ltr" class="gmail_attr">On Wed, Oct 28, 2020 at 9:09 AM Federico Cabiddu <<a href="mailto:federico.cabiddu@gmail.com" target="_blank">federico.cabiddu@gmail.com</a>> wrote:<br></div><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex"><div dir="ltr">Hi Jurijs,<div>I had a look at the logs and there is something strange: I see the ts_append logs before the registrar module ones (the save function). </div><div>Are you sure you are calling ts_append after calling save()?</div><div><br></div><div>Cheers,</div><div><br></div><div>Federico</div></div><br><div class="gmail_quote"><div dir="ltr" class="gmail_attr">On Tue, Oct 27, 2020 at 10:26 AM Jurijs Ivolga <<a href="mailto:jurijs.ivolga@gmail.com" target="_blank">jurijs.ivolga@gmail.com</a>> wrote:<br></div><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex"><div dir="ltr"><div>Hi Daniel-Constantin,</div><div><br></div><div>Debug log is intachment. Do you see any hints?</div><div><br></div><div>I think this is relative part:</div><div><br></div><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex"><div>2020-10-27T08:24:36.198Z,"79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} tsilo [ts_append.c:72]: ts_append(): transaction 21280:984985415 found for <a href="mailto:sip%3A1443452187102-0af7c6035717-0001@voipstaging.myapp.net" target="_blank">sip:1443452187102-0af7c6035717-0001@voipstaging.myapp.net</a>, going to append branches"<br>2020-10-27T08:24:36.198Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} registrar [lookup.c:306]: lookup_helper(): contact for [1443452187102-0af7c6035717-0001] found by address<br>2020-10-27T08:24:36.198Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} tm [t_lookup.c:1612]: t_lookup_ident_filter(): transaction found<br>2020-10-27T08:24:36.199Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} tm [t_append_branches.c:77]: t_append_branches(): transaction 21280:984985415 in status 180<br>2020-10-27T08:24:36.199Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} tm [t_append_branches.c:99]: t_append_branches(): Call <a href="mailto:88cc06a544ba41a8aee5035c437baabf@0.0.0.0" target="_blank">88cc06a544ba41a8aee5035c437baabf@0.0.0.0</a>: 1 (0) outgoing branches<br>2020-10-27T08:24:36.205Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} tm [t_append_branches.c:163]: t_append_branches(): Call <a href="mailto:88cc06a544ba41a8aee5035c437baabf@0.0.0.0" target="_blank">88cc06a544ba41a8aee5035c437baabf@0.0.0.0</a>: 1 (0) outgoing branches after clear_branches()<br>2020-10-27T08:24:36.206Z,"79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} tsilo [ts_append.c:72]: ts_append(): transaction 38832:1600293484 found for <a href="mailto:sip%3A1443452187102-0af7c6035717-0001@voipstaging.myapp.net" target="_blank">sip:1443452187102-0af7c6035717-0001@voipstaging.myapp.net</a>, going to append branches"<br>2020-10-27T08:24:36.206Z,79(85) ERROR: {1 21 REGISTER G~qt15Oz7~} tm [t_append_branches.c:172]:<b> t_append_branches(): failure to add branches (-1)</b><br>2020-10-27T08:24:36.207Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} registrar [lookup.c:306]: lookup_helper(): contact for [1443452187102-0af7c6035717-0001] found by address<br>2020-10-27T08:24:36.207Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} tm [t_append_branches.c:77]: t_append_branches(): transaction 38832:1600293484 in status 180<br>2020-10-27T08:24:36.207Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} tm [t_lookup.c:1612]: t_lookup_ident_filter(): transaction found<br>2020-10-27T08:24:36.208Z,79(85) ERROR: {1 21 REGISTER G~qt15Oz7~} tm [t_append_branches.c:172]: t_append_branches(): failure to add branches (-1)<br>2020-10-27T08:24:36.208Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} tm [t_append_branches.c:99]: t_append_branches(): Call aac9c351-92d0-1239-0599-024233fefdc7: 2 (0) outgoing branches<br>2020-10-27T08:24:36.208Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} tm [t_append_branches.c:163]: t_append_branches(): Call aac9c351-92d0-1239-0599-024233fefdc7: 2 (0) outgoing branches after clear_branches()<br>2020-10-27T08:24:36.209Z,79(85) INFO: {1 21 REGISTER G~qt15Oz7~} <script>: tsilo appending branch <a href="mailto:sip%3A1443452187102-0af7c6035717-0001@voipstaging.myapp.net" target="_blank">sip:1443452187102-0af7c6035717-0001@voipstaging.myapp.net</a><br>2020-10-27T08:24:36.217Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} <core> [core/strutils.c:215]: unescape_user(): unescaped string is <sip:192.168.173.107:55982;transport=tls><br>2020-10-27T08:24:36.218Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} registrar [path.c:116]: build_path_vector(): path is <<sip:<a href="http://ingress1dev.myapp.net" target="_blank">ingress1dev.myapp.net</a>;lr;received=sip:192.168.173.107:55982%3Btransport%3Dtls>><br>2020-10-27T08:24:36.218Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} registrar [path.c:108]: build_path_vector(): received is <sip:192.168.173.107:55982;transport=tls><br>2020-10-27T08:24:36.218Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} registrar [save.c:314]: pack_ci(): set instance[<urn:uuid:2a56856a-fae5-00f6-8f3b-2d9283f533be>]<br>2020-10-27T08:24:36.219Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} <core> [sruid.c:182]: sruid_next(): new sruid is [uloc-5f97d8f4-55-1] (1 / 18)<br>2020-10-27T08:24:36.219Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} registrar [save.c:410]: pack_ci(): generated ruid is: uloc-5f97d8f4-55-1<br>2020-10-27T08:24:36.220Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} registrar [save.c:410]: pack_ci(): generated ruid is: uloc-5f97d8f4-55-2<br>2020-10-27T08:24:36.220Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} <core> [sruid.c:182]: sruid_next(): new sruid is [uloc-5f97d8f4-55-2] (2 / 18)<br>2020-10-27T08:24:36.220Z,"79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} registrar [reply.c:377]: build_contact(): created Contact HF: Contact: <sip:1443452187102-0af7c6035717-0001@192.168.173.107:55982;transport=tls>;q=1;expires=120;received=""sip:192.168.173.107:55982;transport=tls"";+sip.instance=""<urn:uuid:2a56856a-fae5-00f6-8f3b-2d9283f533be>"""<br>2020-10-27T08:24:36.227Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} cfgutils [cfgutils.c:724]: cfg_lock_helper(): cfg_lock mode 0 on 54 (1443452187102-0af7c6035717-0001)<br>2020-10-27T08:24:36.228Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} htable [ht_var.c:89]: pv_set_ht_cell(): set value for $sht(pmap=>join::1443452187102-0af7c6035717-0001)<br>2020-10-27T08:24:36.228Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} cfgutils [cfgutils.c:724]: cfg_lock_helper(): cfg_lock mode 1 on 54 (1443452187102-0af7c6035717-0001)<br>2020-10-27T08:24:36.228Z,79(85) DEBUG: {1 21 REGISTER G~qt15Oz7~} <core> [core/receive.c:437]: receive_msg(): request-route executed in: 2293 usec</div></blockquote><div><div><br></div><div><div><div dir="ltr"><div dir="ltr">Jurijs<br></div></div></div><br></div></div></div><br><div class="gmail_quote"><div dir="ltr" class="gmail_attr">On Tue, Oct 27, 2020 at 10:20 AM Daniel-Constantin Mierla <<a href="mailto:miconda@gmail.com" target="_blank">miconda@gmail.com</a>> wrote:<br></div><blockquote class="gmail_quote" style="margin:0px 0px 0px 0.8ex;border-left:1px solid rgb(204,204,204);padding-left:1ex">
<div>
<p>Hello,</p>
<p>if you get it always, then run with debug=3 and send all the
debug messages here, there should be more hints about why a branch
is not added.</p>
<p>Cheers,<br>
Daniel<br>
</p>
<div>On 27.10.20 08:40, Jurijs Ivolga wrote:<br>
</div>
<blockquote type="cite">
<div dir="ltr">
<div>Hi,</div>
<div><br>
</div>
<div>I have several Kamailio proxies - loadbalancer which is
used as TLS offload and Authorization server and behind
registrar servers.</div>
<div><br>
</div>
<div>In this case I can't make tsilo work on the registrar
server.<br>
</div>
<div><br>
</div>
<div>I'm always getting: "tm [t_append_branches.c:172]:
t_append_branches(): failure to add branches (-1)"</div>
<div><br>
</div>
<div>If I use just one Kamailio which is used as Authorization
and Registrar server then tsilo works as expected.</div>
<div><br>
</div>
<div>Looks like kamailio where I run ts_append tries to connect
to UAC directly and not through Loadbalancer.<br>
</div>
<div><br>
</div>
<div>Any ideas? How can I troubleshoot this?<br>
</div>
<div><br>
</div>
<div>Thank you!<br>
</div>
<div><br>
</div>
<div>
<div dir="ltr">
<div dir="ltr">Jurijs<br>
</div>
</div>
</div>
</div>
<br>
<fieldset></fieldset>
<pre>_______________________________________________
Kamailio (SER) - Users Mailing List
<a href="mailto:sr-users@lists.kamailio.org" target="_blank">sr-users@lists.kamailio.org</a>
<a href="https://lists.kamailio.org/cgi-bin/mailman/listinfo/sr-users" target="_blank">https://lists.kamailio.org/cgi-bin/mailman/listinfo/sr-users</a>
</pre>
</blockquote>
<pre cols="72">--
Daniel-Constantin Mierla -- <a href="http://www.asipto.com" target="_blank">www.asipto.com</a>
<a href="http://www.twitter.com/miconda" target="_blank">www.twitter.com/miconda</a> -- <a href="http://www.linkedin.com/in/miconda" target="_blank">www.linkedin.com/in/miconda</a>
Funding: <a href="https://www.paypal.me/dcmierla" target="_blank">https://www.paypal.me/dcmierla</a></pre>
</div>
</blockquote></div>
_______________________________________________<br>
Kamailio (SER) - Users Mailing List<br>
<a href="mailto:sr-users@lists.kamailio.org" target="_blank">sr-users@lists.kamailio.org</a><br>
<a href="https://lists.kamailio.org/cgi-bin/mailman/listinfo/sr-users" rel="noreferrer" target="_blank">https://lists.kamailio.org/cgi-bin/mailman/listinfo/sr-users</a><br>
</blockquote></div>
_______________________________________________<br>
Kamailio (SER) - Users Mailing List<br>
<a href="mailto:sr-users@lists.kamailio.org" target="_blank">sr-users@lists.kamailio.org</a><br>
<a href="https://lists.kamailio.org/cgi-bin/mailman/listinfo/sr-users" rel="noreferrer" target="_blank">https://lists.kamailio.org/cgi-bin/mailman/listinfo/sr-users</a><br>
</blockquote></div>
</blockquote></div></div>