<div>šDoes someone have any idea how to handle it?<br /></div><div>š<br /></div><div>05.03.2015, 16:22, "þÁÌËÏ× áÒÔ£Í" &lt;achalkov@ya.ru&gt;:</div><blockquote type="cite"><div><p>debug=4<br /><br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:tcp_read_req: We're releasing the connection in state 3<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:io_watch_del: io_watch_del op on index -1 36 (0x77dee0, 36, -1, 0x10,0x1) fd_no=2 called<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:release_tcpconn: šreleasing con 0x7f2be91663a8, state 0, fd=36, id=1<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:release_tcpconn: šextra_data (nil)<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_msg: SIP Request:<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_msg: šmethod: š&lt;MESSAGE&gt;<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19028]: DBG:core:handle_tcp_child: reader response= 7f2be91663a8, 0 from 0<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_msg: šuri: šššš&lt;sip:<a>achalkov1@x.x.x.x</a>:3631;transport=TCP&gt;<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19028]: DBG:core:io_watch_add: io_watch_add op on 52 (0x77dd80, 52, 2, 0x7f2be91663a8,1), fd_no=38<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_msg: šversion: &lt;SIP/2.0&gt;<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_headers: flags=2<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_via_param: found param type 232, &lt;branch&gt; = &lt;z9hG4bK-d8754z-668ef50b1a4c0a31-1---d8754z-&gt;; state=6<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_via_param: found param type 235, &lt;rport&gt; = &lt;n/a&gt;; state=17<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_via: end of header reached, state=5<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_headers: via found, flags=2<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_headers: this is the first via<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:receive_msg: After parse_msg...<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:receive_msg: preparing to run routing scripts...<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_headers: flags=<span>8000000</span><br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_to: end of header reached, state=10<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_to: display={}, ruri={sip:<a>achalkov1@x.x.x.x</a>:3631;transport=TCP}<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:get_hdr_field: &lt;To&gt; [51]; uri=[sip:<a>achalkov1@x.x.x.x</a>:3631;transport=TCP]<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:get_hdr_field: to body [&lt;sip:<a>achalkov1@x.x.x.x</a>:3631;transport=TCP&gt;#015#012]<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:get_hdr_field: cseq &lt;CSeq&gt;: &lt;3&gt; &lt;MESSAGE&gt;<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:maxfwd:is_maxfwd_present: value = 70<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_headers: flags=ffffffffffffffff<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:get_hdr_field: content_length=3<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:get_hdr_field: found end of header<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_headers: flags=ffffffffffffffff<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:decode_mime_type: Decoding MIME type for:[text/plain]<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_to_param: tag=b2b91161<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_to: end of header reached, state=29<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_to: display={"achalkov"}, ruri={sip:<a>achalkov@x.x.x.x</a>:3631;transport=TCP}<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_headers: flags=ffffffffffffffff<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_methods: methods 0x173F<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:uri:has_totag: no totag<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_headers: flags=78<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:tm:t_lookup_request: start searching: hash=32018, isACK=0<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:tm:matching_3261: RFC3261 transaction matching failed<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:tm:t_lookup_request: no transaction found<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_headers: flags=200<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:rr:find_first_route: No Route headers found<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:rr:loose_route: There is no Route HF<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:auth:check_nonce: comparing [54f85536be0ae02858c2001d58774c222d958f86] and [54f85536be0ae02858c2001d58774c222d958f86]<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:db_mysql:has_stmt_ctx: ctx found for subscriber<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:db_mysql:db_mysql_do_prepared_query: conn=0x7f2bef4e28b0 (tail=<span>139826675195936</span>) MC=0x7f2bef4e2080<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:db_mysql:db_mysql_do_prepared_query: set values for the statement run<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:db_mysql:db_mysql_val2bind: added val (0): len=8; type=254; is_null=0<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:db_mysql:db_mysql_do_prepared_query: doing BIND_PARAM in...<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:db_mysql:mysql_raise_event: MySQL status has not changed: connected<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:db_mysql:db_mysql_do_prepared_query: prepared statement has 2 columns in result<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:db_new_result: allocate 48 bytes for result set at 0x7f2bef4f5968<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:db_mysql:db_mysql_get_columns: 2 columns returned from the query<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:db_allocate_columns: allocate 56 bytes for result columns at 0x7f2bef4f6368<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x7f2bef4f6378)[0]=[ha1]<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x7f2bef4f6388)[1]=[mediaproxy]<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:db_allocate_rows: allocate 80 bytes for result rows and values at 0x7f2bef4f6a48<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:db_mysql:db_mysql_str2val: converting STRING [659cc07a1ab8ccbbc3b5ec2172bc6473]<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:auth:check_response: our result = '06223b730875bf2c01ad98448dd08438'<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:auth:check_response: authorization is OK<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:db_free_columns: freeing result columns at 0x7f2bef4f6368<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:db_free_rows: freeing 1 rows<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:db_free_row: freeing row values at 0x7f2bef4f6a58<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:db_free_rows: freeing rows at 0x7f2bef4f6a48<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:db_free_result: freeing result set at 0x7f2bef4f5968<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:registrar:lookup: found a complete match<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:registrar:lookup: setting as ruri &lt;sip:<a>achalkov1@192.168.1.210</a>:65062;transport=TLS;ob&gt;<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:registrar:lookup: looking for branches<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:registrar:lookup: found a complete match<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:registrar:lookup: setting as ruri &lt;sip:<a>achalkov1@192.168.1.210</a>:65062;transport=TLS;ob&gt;<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:registrar:lookup: looking for branches<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:comp_scriptvar: str 29 : 83.149.9.184<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:tm:t_newtran: transaction on entrance=(nil)<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_headers: flags=ffffffffffffffff<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_headers: flags=78<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:tm:t_lookup_request: start searching: hash=32018, isACK=0<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:tm:matching_3261: RFC3261 transaction matching failed<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:tm:t_lookup_request: no transaction found<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:tm:run_reqin_callbacks: trans=0x7f2be91669a0, callback type 1, id 1 entered<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:tm:run_reqin_callbacks: trans=0x7f2be91669a0, callback type 1, id 0 entered<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:_shm_resize: resize(0) called<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:mk_proxy: doing DNS lookup...<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:parse_headers: flags=2000<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:build_req_buf_from_sip_req: id added: &lt;;i=1&gt;, rcv proto=2<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:tcp_send: no open tcp connection found, opening new one<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: getsockopt: snd is initially 16384<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 32768<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=32768,verify=65536<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 65536<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=65536,verify=131072<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 131072<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=131072,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 262144<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=262144,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting buf has no effect<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 133120<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=133120,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 135168<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=135168,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 137216<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=137216,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 139264<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=139264,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 141312<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=141312,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 143360<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=143360,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 145408<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=145408,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 147456<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=147456,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 149504<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=149504,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 151552<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=151552,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 153600<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=153600,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 155648<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=155648,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 157696<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=157696,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 159744<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=159744,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 161792<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=161792,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 163840<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=163840,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 165888<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=165888,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 167936<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=167936,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: trying : 169984<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19012]: DBG:core:probe_max_sock_buff: setting snd: set=169984,verify=262142<br />Mar š5 16:07:46 cs17792 /usr/sbin/opensips[19028]: DBG:core:handle_ser_child: read response= 7f2be91663a8, 1, fd -1 from 17 (19012)<br />Mar š5 16:07:49 cs17792 /usr/sbin/opensips[19010]: DBG:avpops:ops_dbquery_avps: query [SELECT username FROM silo GROUP BY username HAVING count(*) &gt; 0]<br />Mar š5 16:07:49 cs17792 /usr/sbin/opensips[19010]: DBG:db_mysql:mysql_raise_event: MySQL status has not changed: connected<br />Mar š5 16:07:49 cs17792 /usr/sbin/opensips[19010]: DBG:core:db_new_result: allocate 48 bytes for result set at 0x7f2bef4e3aa8<br />Mar š5 16:07:49 cs17792 /usr/sbin/opensips[19010]: DBG:db_mysql:db_mysql_get_columns: 1 columns returned from the query<br />Mar š5 16:07:49 cs17792 /usr/sbin/opensips[19010]: DBG:core:db_allocate_columns: allocate 28 bytes for result columns at 0x7f2bef4e3af0<br />Mar š5 16:07:49 cs17792 /usr/sbin/opensips[19010]: DBG:db_mysql:db_mysql_get_columns: RES_NAMES(0x7f2bef4e3af8)[0]=[username]<br />Mar š5 16:07:49 cs17792 /usr/sbin/opensips[19010]: DBG:db_mysql:db_mysql_get_columns: use DB_STRING result type<br />Mar š5 16:07:49 cs17792 /usr/sbin/opensips[19010]: DBG:db_mysql:db_mysql_convert_rows: no rows returned from the query<br />Mar š5 16:07:49 cs17792 /usr/sbin/opensips[19010]: DBG:avpops:db_query_avp: no result after query<br />Mar š5 16:07:49 cs17792 /usr/sbin/opensips[19010]: DBG:avpops:db_close_query: close avp query<br />Mar š5 16:07:49 cs17792 /usr/sbin/opensips[19010]: DBG:core:db_free_columns: freeing result columns at 0x7f2bef4e3af0<br />Mar š5 16:07:49 cs17792 /usr/sbin/opensips[19010]: DBG:core:db_free_rows: freeing 0 rows<br />Mar š5 16:07:49 cs17792 /usr/sbin/opensips[19010]: DBG:core:db_free_result: freeing result set at 0x7f2bef4e3aa8<br />Mar š5 16:07:49 cs17792 /usr/sbin/opensips[19010]: DBG:core:destroy_avp_list: destroying list (nil)<br />Mar š5 16:07:52 cs17792 /usr/sbin/opensips[19009]: DBG:tm:timer_routine: timer routine:2,tl=0x7f2be9166a20 next=(nil), timeout=36<br />Mar š5 16:07:52 cs17792 /usr/sbin/opensips[19009]: DBG:tm:wait_handler: removing 0x7f2be91669a0 from table<br />Mar š5 16:07:52 cs17792 /usr/sbin/opensips[19009]: DBG:tm:delete_cell: delete transaction 0x7f2be91669a0<br />Mar š5 16:07:52 cs17792 /usr/sbin/opensips[19009]: DBG:tm:wait_handler: done<br /><br />debug=3 with check<br /><br />ššššššššššššššššif ($si != "127.0.0.1") t_on_failure("ON_FAIL_MESSAGE");<br />ššššššššššššššššt_relay("0x01");<br />šššššššššššššššš$var(retcode) = $retcode;<br />ššššššššššššššššxlog("L_INFO", "[!!!MESSAGE_DEBUG!!!] t_relay returns $var(retcode)");<br /><br />Mar š5 16:15:01 cs17792 /usr/sbin/opensips[19205]: [MAIN] Incoming request (MESSAGE)<br />Mar š5 16:15:01 cs17792 /usr/sbin/opensips[19205]: INFO:core:probe_max_sock_buff: using snd buffer of 255 kb<br />Mar š5 16:15:01 cs17792 /usr/sbin/opensips[19205]: INFO:core:init_sock_keepalive: -- TCP keepalive enabled on socket<br />Mar š5 16:15:01 cs17792 /usr/sbin/opensips[19205]: ERROR:core:tcp_blocking_connect: poll error: flags <span>24 - 4 8 16 32</span><br />Mar š5 16:15:01 cs17792 /usr/sbin/opensips[19205]: ERROR:core:tcp_blocking_connect: failed to retrieve SO_ERROR [server=x.x.x.x:65106] (111) Connection refused<br />Mar š5 16:15:01 cs17792 /usr/sbin/opensips[19205]: ERROR:core:tcpconn_connect: tcp_blocking_connect failed<br />Mar š5 16:15:01 cs17792 /usr/sbin/opensips[19205]: ERROR:core:tcp_send: connect failed<br />Mar š5 16:15:01 cs17792 /usr/sbin/opensips[19205]: ERROR:tm:msg_send: tcp_send failed<br />Mar š5 16:15:01 cs17792 /usr/sbin/opensips[19205]: ERROR:tm:t_forward_nonack: sending request failed<br />Mar š5 16:15:01 cs17792 /usr/sbin/opensips[19205]: [!!!MESSAGE_DEBUG!!!] t_relay returns 1 <br /><br /><br />05.03.2015, 15:39, "Vlad Paiu" &lt;<a>vladpaiu@opensips.org</a>&gt;:<br /></p><blockquote>šHello,<br /><br />šSince TLS doesn't support async in 1.11, you should get an error<br />šstraight out of t_relay()<br />šCan you please post the full debug logs here ?<br /><br />šBest Regards,<br /><br />šVlad Paiu<br />šOpenSIPS Developer<br />š<a href="http://www.opensips-solutions.com/" data-vdir-href="http://www.opensips-solutions.com/" data-orig-href="http://www.opensips-solutions.com/" target="_blank">http://www.opensips-solutions.com</a><br /><br />šOn 05.03.2015 13:44, þÁÌËÏ× áÒԣ͠wrote:<br /><blockquote>ššHi all!<br /><br />ššCan someone help us?. I cannot understand how TLS in opensips 1.11 works.<br />ššThe problem is when we use TLS, i cannot handle connection problems.<br /><br />ššWhen i use TCP in async mode, i have 408 in failure route when outgoing TCP connection fails, when i use TCP in sync mode, i have negative status after t_relay(), however, after TLS, i cannot catch neither 408, or negative t_relay() status. So, how to handle TLS connection error?<br /><br />šš_______________________________________________<br />ššUsers mailing list<br />šš<a>Users@lists.opensips.org</a><br />šš<a href="http://lists.opensips.org/cgi-bin/mailman/listinfo/users" data-vdir-href="http://lists.opensips.org/cgi-bin/mailman/listinfo/users" data-orig-href="http://lists.opensips.org/cgi-bin/mailman/listinfo/users" target="_blank">http://lists.opensips.org/cgi-bin/mailman/listinfo/users</a><br /></blockquote>š_______________________________________________<br />šUsers mailing list<br />š<a>Users@lists.opensips.org</a><br />š<a href="http://lists.opensips.org/cgi-bin/mailman/listinfo/users" data-vdir-href="http://lists.opensips.org/cgi-bin/mailman/listinfo/users" data-orig-href="http://lists.opensips.org/cgi-bin/mailman/listinfo/users" target="_blank">http://lists.opensips.org/cgi-bin/mailman/listinfo/users</a><br /></blockquote><p>_______________________________________________<br />Users mailing list<br /><a>Users@lists.opensips.org</a><br /><a href="http://lists.opensips.org/cgi-bin/mailman/listinfo/users" data-vdir-href="http://lists.opensips.org/cgi-bin/mailman/listinfo/users" data-orig-href="http://lists.opensips.org/cgi-bin/mailman/listinfo/users" target="_blank">http://lists.opensips.org/cgi-bin/mailman/listinfo/users</a><br /></p></div></blockquote>