From riffs@sina.cn Wed Sep 13 05:57:48 2023
From: riffs@sina.cn
To: sr-dev@lists.kamailio.org
Subject: [sr-dev] client sending message and refresh register normal. But
 KSR.uac.uac_req_send() from server ERROR
Date: Wed, 13 Sep 2023 05:57:39 +0000
Message-ID: <169458465954.1539.4334778539855119777@main.kamailio.org>
MIME-Version: 1.0
Content-Type: multipart/mixed; boundary="===============1811984568=="

--===============1811984568==
Content-Type: text/plain; charset="utf-8"
Content-Transfer-Encoding: quoted-printable

The client uses the TLS protocol registered and TCP Connection established . =
There is a problem now, sending message KSR.uac.uac_req_send() from the kamil=
io server to client failed sometimes,and the error is as follows=EF=BC=9A
  =E2=80=9C2023-09-04T17:22:01.515763+08:00 (3429) ERROR: tm [../../core/forw=
ard.h:292]: msg_send_buffer(): tcp_send failed
  2023-09-04T17:22:01.515763+08:00 (3429) ERROR: tm [uac.c:678]: send_prepare=
d_request_impl(): Attempt to send to precreated request failed =E2=80=9D.   m=
eantime, the client sending message to Kamalio server succeded, and the regis=
ter status and tcp connection is normal.

  After 30s, obtained the $uac_req(evcode) from the event_route[uac:reply] is=
 408.After this error appears, all the messages sent to this client are 408.
  "
2023-08-29T03:48:43.738152+08:00  (3349) NOTICE: <script>: =3D=3D=3Duac reply=
 received, callid =3D 0B6ECB534AE24281AED9BBBC56B140A6`yangwang2`1693252093, =
code is: 408
2023-08-29T03:48:43.738825+08:00  (3349) NOTICE: <script>: =3D=3D=3Duac reply=
 received, callid =3D 0B6ECB534AE24281AED9BBBC56B140A6`yangwang2`1693252093, =
code is: 408
  "

  But from other information, the TCP connection is normal. Because from Kama=
ilio to querying this user's Location, it has not changed all day. The client=
 sends messages is also normal. That is, the user's registration and sending =
messages can receive 200 OK.
  We use netstat commands to view the user's TCP connection information on th=
e client and server, and the connection status is also normal.The status of t=
he corresponding port of the TCP connection is ESTABLISHED.
   client:
  netstat  -ano  | findstr 49957
  "172. 17. 47.125:49957  XXX.96.XXX.XXX:5061 ESTABLISHED  10516"
  server:
  "tcp 0  0 10.11.xx.xx:5061   xxx.xxx.xxx.xxx:49957 ESTABLISHED  3467/kamail=
io" =20
  This client is normal after logging in, and the problem that occurs after a=
 period of use (maybe some hours), and once it occurs, it fails until the use=
r creates a new connection and logs back in. Not all users will appear.

  Why is this the case? The socket connection is fine, but uac_req_send () ge=
t an ERROR?
  I found a problem from the log file. Is it caused by duplicate callids push=
ed to the same user at the same second?

  Looking forward to your answer, thank you very much
=09
  Script information that may be required

  kamailio.cfg =EF=BC=9A tm mode=20
  # ----- tm params -----
  # auto-discard branches from previous serial forking leg
  modparam("tm", "failure_reply_mode", 3)
  # default retransmission timeout: 30sec
  modparam("tm", "fr_timer", 30000)
  # default invite retransmission timeout after 1xx: 120sec
  modparam("tm", "fr_inv_timer", 120000)
  modparam("tm", "auto_inv_100", 1)

  kamalio.lua uac_req_send()
  "	--uac_req_send  =E6=8E=A8=E9=80=81=E7=BB=99=E7=BB=88=E7=AB=AF
                KSR.pv.sets("$uac_req(hdrs)", hdrs)
	KSR.pv.sets("$uac_req(method)", "MESSAGE")
	KSR.pv.sets("$uac_req(ruri)", "sip:" .. to .. "@" .. KAM_DOMAIN)
	KSR.pv.sets("$uac_req(furi)", "sip:" .. from .. "@" .. KAM_DOMAIN)
	KSR.pv.sets("$uac_req(turi)", "sip:" .. to .. "@" .. KAM_DOMAIN)
	KSR.pv.seti("$uac_req(evroute)", 1)
	KSR.pv.sets("$uac_req(body)", content)
	local ouri =3D (row.received ~=3D "" and row.received) or row.contact=20
	KSR.pv.sets("$uac_req(ouri)", ouri)
	local callid =3D rows[i].clientid .. "`" .. rows[i].username .. "`" .. os.ti=
me()
	KSR.pv.sets("$uac_req(callid)", callid)
        KSR.uac.uac_req_send()

--===============1811984568==--