[Freeswitch-users] Expert help needed debuging sip registration [logs included]

Miguel Andrade miguel.andrade at neoscopio.com
Fri Oct 15 15:43:24 UTC 2021 

Some how I'm able to register sip phones and softphones but not as a
freeswitch gateway. I've tried several combinations to no avail.


My provider instructions are:


· Endereço Registar (Host): sip.sapo.pt

· Endereço Proxy (Outbound Proxy): proxy.sip.sapo.pt

· Porta Proxy: 5070

· Username: +3513020xxxxx (*)

· Password: [de 6 a 8 carateres]

· Transporte Rede (Network Settings): UDP

· SIP URL: +3513020xxxxx (*)


I've entered this as username: +351xxx, password: xxx, proxy:
proxy.sip.sapo.pt:5070 , from domain: sip.sapo.pt

Doesn't work.

I went to advanced and set transport to udp and outbound proxy as
proxy.sip.sapo.pt:5070 didn't work wither.

Tried all combinations I could but also no cigar.


Can anyone help me debug this?


Here are some fs_cli logs:



2021-10-15 15:41:46.615028 [NOTICE] sofia_reg.c:454 Registering
ebf96e38-7592-43b7-82fa-4a9fd4c5facf

nua_stack.c:569 nua_stack_signal() nua(0x7f6730005880): recv signal
r_register

nua_dialog.c:336 nua_dialog_usage_add() nua(0x7f6730005880): adding
register usage

nta.c:2670 nta_tpn_by_url() nta: selecting scheme sip

nta.c:10831 outgoing_query_a() nta: for "proxy.sip.sapo.pt" query "
proxy.sip.sapo.pt" A (cached)

nta.c:10886 outgoing_answer_a() nta: proxy.sip.sapo.pt. IN A 194.65.2.241

tport.c:3274 tport_tsend() tport_tsend(0x7f6724195450) tpn = udp/
194.65.2.241:5070

tport.c:4697 tport_by_addrinfo() tport_by_addrinfo(0x7f6724195450): not
found by name udp/194.65.2.241:5070

tport.c:3609 tport_vsend() tport_vsend(0x7f6724195450): 642 bytes of 642 to
udp/194.65.2.241:5070

nua_stack.c:528 nua_signal() nua(0x7f6730005880): sent signal r_register

send 642 bytes to udp/[194.65.2.241]:5070 at 15:41:46.632220:

------------------------------------------------------------------------

REGISTER sip[image: image.gif]roxy.sip.sapo.pt:5070;transport=udp SIP/2.0

Via: SIP/2.0/UDP 92.222.246.205:5080;rport;branch=z9hG4bKc0QF2jmNeB8Qe

Max-Forwards: 70

From: <sip:+351302020304 at sip.sapo.pt>;tag=HjK0rD25pc27a

To: <sip:+351302020304 at sip.sapo.pt>

Call-ID: 8ab00b1b-ec4d-4564-b148-26fcb82622e1

CSeq: 42600661 REGISTER

Contact: <sip:gw+ebf96e38-7592-43b7-82fa-4a9fd4c5facf at 92.222.246.205:5080
;transport=udp;gw=ebf96e38-7592-43b7-82fa-4a9fd4c5facf>

Expires: 60

User-Agent: Grandstream HT802 1.0.3.2

Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER,
REFER, NOTIFY

Supported: timer, path, replaces

Content-Length: 0


nta.c:8312 outgoing_send() nta: sent REGISTER (42600661) to udp/
194.65.2.241:5070

tport.c:4175 tport_pend() tport_pend(0x7f6724195450): pending
0x7f67241145e0 for udp/92.222.246.205:5080 (already 0)

tport.c:2751 tport_wakeup_pri() tport_wakeup_pri(0x7f6724195450): events IN

tport.c:2882 tport_recv_event() tport_recv_event(0x7f6724195450)

tport.c:3219 tport_recv_iovec() tport_recv_iovec(0x7f6724195450) msg
0x7f672416c140 from (udp/92.222.246.205:5080) has 602 bytes, veclen = 1

recv 602 bytes from udp/[194.65.2.241]:5070 at 15:41:46.753181:

------------------------------------------------------------------------

SIP/2.0 401 Unauthorized 11030230330

Via: SIP/2.0/UDP 92.222.246.205:5080
;received=92.222.246.205;branch=z9hG4bKc0QF2jmNeB8Qe;rport=5080

From: <sip:+351302020304 at sip.sapo.pt>;tag=HjK0rD25pc27a

To: <sip:+351302020304 at sip.sapo.pt>;tag=9848f21803d1705ce6531d6ca2f

Call-ID: 8ab00b1b-ec4d-4564-b148-26fcb82622e1

CSeq: 42600661 REGISTER

Content-Length: 0

WWW-Authenticate: Digest nonce="D734DDD02A93696100000000E09BC51B",realm="
ims.telecom.pt",algorithm=MD5,qop="auth"

P-Charging-Vector:
icid-value=3bnhe046p1ds2rk6ehcs2pg6hhoamfde9rpulo4623db2jmt;icid-generated-at=194.65.2.241;orig-ioi=internet


tport.c:3037 tport_deliver() tport_deliver(0x7f6724195450): msg
0x7f672416c140 (602 bytes) from udp/194.65.2.241:5080/sip next=(nil)

nta.c:3303 agent_recv_response() nta: received 401 Unauthorized 11030230330
for REGISTER (42600661)

nta.c:3370 agent_recv_response() nta: 401 Unauthorized 11030230330 is going
to a transaction

nta.c:9584 outgoing_estimate_delay() nta_outgoing: RTT is 121.007 ms

tport.c:4237 tport_release() tport_release(0x7f6724195450): 0x7f67241145e0
by 0x7f672454b980 with 0x7f672416c140

auth_digest.c:105 auth_digest_challenge_get() auth_digest_challenge_get():
got 6

nua_stack.c:271 nua_stack_event() nua(0x7f6730005880): event r_register 401
Unauthorized 11030230330

nua_stack.c:528 nua_signal() nua(0x7f6730005880): sent signal r_authenticate

nua_stack.c:569 nua_stack_signal() nua(0x7f6730005880): recv signal
r_authenticate

auth_digest.c:225 auth_digest_a1() auth_digest_a1() has A1 =
MD5(+351302020304:ims.telecom.pt:1q2w!Q) = 8038cbcec02479ac6c24e22c0d4d343a

auth_digest.c:317 auth_digest_response() A2 = MD5(REGISTER:sip[image:
image.gif]roxy.sip.sapo.pt:5070;transport=udp)

auth_digest.c:339 auth_digest_response() auth_response:
72688ed841494a95193f7d115c409667 = MD5(8038cbcec02479ac6c24e22c0d4d343a[image:
image.gif]
734DDD02A93696100000000E09BC51B:00000001:3UagCahoEjqJ2gIAACyybQ:auth:66f331

b6539f207dc0b673edce10bbbc) (qop=auth)

nta.c:2670 nta_tpn_by_url() nta: selecting scheme sip

nta.c:10831 outgoing_query_a() nta: for "proxy.sip.sapo.pt" query "
proxy.sip.sapo.pt" A (cached)

nta.c:10886 outgoing_answer_a() nta: proxy.sip.sapo.pt. IN A 194.65.2.241

tport.c:3274 tport_tsend() tport_tsend(0x7f6724195450) tpn = udp/
194.65.2.241:5070

tport.c:4697 tport_by_addrinfo() tport_by_addrinfo(0x7f6724195450): not
found by name udp/194.65.2.241:5070

tport.c:3609 tport_vsend() tport_vsend(0x7f6724195450): 920 bytes of 920 to
udp/194.65.2.241:5070

send 920 bytes to udp/[194.65.2.241]:5070 at 15:41:46.753392:

------------------------------------------------------------------------

REGISTER sip[image: image.gif]roxy.sip.sapo.pt:5070;transport=udp SIP/2.0

Via: SIP/2.0/UDP 92.222.246.205:5080;rport;branch=z9hG4bKD9g83D5rBmyaa

Max-Forwards: 70

From: <sip:+351302020304 at sip.sapo.pt>;tag=HjK0rD25pc27a

To: <sip:+351302020304 at sip.sapo.pt>

Call-ID: 8ab00b1b-ec4d-4564-b148-26fcb82622e1

CSeq: 42600662 REGISTER

Contact: <sip:gw+ebf96e38-7592-43b7-82fa-4a9fd4c5facf at 92.222.246.205:5080
;transport=udp;gw=ebf96e38-7592-43b7-82fa-4a9fd4c5facf>

Expires: 60

User-Agent: Grandstream HT802 1.0.3.2

Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER,
REFER, NOTIFY

Supported: timer, path, replaces

Authorization: Digest username="+351302020304", realm="ims.telecom.pt",
nonce="D734DDD02A93696100000000E09BC51B", cnonce="3UagCahoEjqJ2gIAACyybQ",
algorithm=MD5, uri="sip[image: image.gif]roxy.sip.sapo.pt:5070;transport=

udp", response="72688ed841494a95193f7d115c409667", qop=auth, nc=00000001

Content-Length: 0


nta.c:8312 outgoing_send() nta: sent REGISTER (42600662) to udp/
194.65.2.241:5070

tport.c:4175 tport_pend() tport_pend(0x7f6724195450): pending
0x7f67242e5a90 for udp/92.222.246.205:5080 (already 0)

tport.c:2751 tport_wakeup_pri() tport_wakeup_pri(0x7f6724195450): events IN

tport.c:2882 tport_recv_event() tport_recv_event(0x7f6724195450)

tport.c:3219 tport_recv_iovec() tport_recv_iovec(0x7f6724195450) msg
0x7f67242d2000 from (udp/92.222.246.205:5080) has 602 bytes, veclen = 1

recv 602 bytes from udp/[194.65.2.241]:5070 at 15:41:46.871252:

------------------------------------------------------------------------

SIP/2.0 401 Unauthorized 1103023032F

Via: SIP/2.0/UDP 92.222.246.205:5080
;received=92.222.246.205;branch=z9hG4bKD9g83D5rBmyaa;rport=5080

From: <sip:+351302020304 at sip.sapo.pt>;tag=HjK0rD25pc27a

To: <sip:+351302020304 at sip.sapo.pt>;tag=9848f2180cea805ce6531d8948d

Call-ID: 8ab00b1b-ec4d-4564-b148-26fcb82622e1

CSeq: 42600662 REGISTER

Content-Length: 0

WWW-Authenticate: Digest nonce="47DFEAEB2A936961000000000782EF64",realm="
ims.telecom.pt",algorithm=MD5,qop="auth"

P-Charging-Vector:
icid-value=3bnhe046p1ds2rk6ehcs2pg6hhoamfde9rpulo462blb2jmt;icid-generated-at=194.65.2.241;orig-ioi=internet


tport.c:3037 tport_deliver() tport_deliver(0x7f6724195450): msg
0x7f67242d2000 (602 bytes) from udp/194.65.2.241:5080/sip next=(nil)

nta.c:3303 agent_recv_response() nta: received 401 Unauthorized 1103023032F
for REGISTER (42600662)

nta.c:3370 agent_recv_response() nta: 401 Unauthorized 1103023032F is going
to a transaction

nta.c:9584 outgoing_estimate_delay() nta_outgoing: RTT is 117.905 ms

tport.c:4237 tport_release() tport_release(0x7f6724195450): 0x7f67242e5a90
by 0x7f672410d3b0 with 0x7f67242d2000

auth_digest.c:105 auth_digest_challenge_get() auth_digest_challenge_get():
got 6

nua_client.c:1223 nua_base_client_check_restart() nua(0x7f6730005880): bad
credentials, clearing them

nua_stack.c:271 nua_stack_event() nua(0x7f6730005880): event r_register 401
Unauthorized 1103023032F

nua_stack.c:528 nua_signal() nua(0x7f6730005880): sent signal r_authenticate

nua_stack.c:569 nua_stack_signal() nua(0x7f6730005880): recv signal
r_authenticate

nua_stack.c:271 nua_stack_event() nua(0x7f6730005880): event r_register 904
Operation has no matching challenge

nua_dialog.c:395 nua_dialog_usage_remove_at() nua(0x7f6730005880): removing
register usage

2021-10-15 15:41:46.854983 [ERR] sofia_reg.c:2470
ebf96e38-7592-43b7-82fa-4a9fd4c5facf Failed Registration with status
Operation has no matching challenge  [904]. failure #1
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20211015/4fc27e1d/attachment-0001.html>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: image.gif
Type: image/gif
Size: 42 bytes
Desc: not available
URL: <http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20211015/4fc27e1d/attachment-0005.gif>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: image.gif
Type: image/gif
Size: 42 bytes
Desc: not available
URL: <http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20211015/4fc27e1d/attachment-0006.gif>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: image.gif
Type: image/gif
Size: 42 bytes
Desc: not available
URL: <http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20211015/4fc27e1d/attachment-0007.gif>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: image.gif
Type: image/gif
Size: 42 bytes
Desc: not available
URL: <http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20211015/4fc27e1d/attachment-0008.gif>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: image.gif
Type: image/gif
Size: 42 bytes
Desc: not available
URL: <http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20211015/4fc27e1d/attachment-0009.gif>

More information about the FreeSWITCH-users mailing list