# SIP cliend behind NAT can't connect **URL:** \ **Category:** Asterisk Support\ **Created:** [March 14, 2014, 4:49pm UTC](https://community.asterisk.org/t/sip-cliend-behind-nat-cant-connect/45558 "2014-03-14T16:49:43Z")\ **Posts on this page:** 4\ **Page:** 1
**Author:** ![beaver\_rrr](https://sea1.discourse-cdn.com/asterisk/user_avatar/community.asterisk.org/beaver_rrr/32/228_2.png) [@beaver\_rrr](https://community.asterisk.org/u/beaver_rrr)\ **Post date:** [March 14, 2014, 4:49pm UTC](https://community.asterisk.org/t/sip-cliend-behind-nat-cant-connect/45558/1 "2014-03-14T16:49:43Z")
I have a following scheme: ```auto [asterisk server] | [internet] | [firewall] | | [103] [104] ``` Client #104 can connect to asterisk, shown properly in ‘sip show status’ `104/104 87.245.129.xx D N 14357 OK (1 ms) ` Client #103 does this: ` -- Unregistered SIP '103' -- Registered SIP '103' at 192.168.1.54:5060 -- Registered SIP '103' at 87.245.129.xx:5060 -- Unregistered SIP '103'` It can call #104, but can not be called as it gives this: ```auto ``` sip.conf for #103 and #104 `[103] username=103 secret=secret type=friend host=dynamic directmedia=no context=psssh callgroup=1 pickupgroup=1 nat=yes qualify=yes [104] username=104 secret=secret type=friend host=dynamic directmedia=no context=psssh callgroup=1 pickupgroup=1 nat=yes qualify=yes` #104 is a MicroSIP softphone, #103 is a Konftel 300IP phone. Both live in same small network, no VLANs, nothing, they have same conditions, but one works when other does not ☹ Any ideas how to make it work? I’ve tried to look into sip debug, found out that it registers, but then something happens and i see ```auto ``` Tried googling that, found out possible codec problems, fixed them, but to no avail. ---
**Author:** ![beaver\_rrr](https://sea1.discourse-cdn.com/asterisk/user_avatar/community.asterisk.org/beaver_rrr/32/228_2.png) [@beaver\_rrr](https://community.asterisk.org/u/beaver_rrr)\ **Post date:** [March 15, 2014, 12:16pm UTC](https://community.asterisk.org/t/sip-cliend-behind-nat-cant-connect/45558/2 "2014-03-15T12:16:41Z")
There are two SIP debug logs, both showing a client connect and register. This one for 104, which works fine: [code][Mar 15 15:59:12] VERBOSE[15255] chan\_sip.c: \<— SIP read from UDP:$FIREWALL\_IP:5060 —\> REGISTER sip:$ASTERISK\_IP SIP/2.0 Via: SIP/2.0/UDP 192.168.1.200:5060;rport;branch=z9hG4bKPja2e51b8071484c84905a5a715cc02fd3 Max-Forwards: 70 From: “104” sip:104@$ASTERISK\_IP;tag=df488cd5a2244656a86218d790a2f0cb To: “104” sip:104@$ASTERISK\_IP Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 CSeq: 49313 REGISTER User-Agent: MicroSIP/3.3.27 Contact: “104” sip:104@192.168.1.200:5060;ob Expires: 300 Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Content-Length: 0 \<-------------\> [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 0 [34]: REGISTER sip:$ASTERISK\_IP SIP/2.0 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 1 [90]: Via: SIP/2.0/UDP 192.168.1.200:5060;rport;branch=z9hG4bKPja2e51b8071484c84905a5a715cc02fd3 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 2 [16]: Max-Forwards: 70 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 3 [72]: From: “104” sip:104@$ASTERISK\_IP;tag=df488cd5a2244656a86218d790a2f0cb [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 4 [33]: To: “104” sip:104@$ASTERISK\_IP [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 5 [41]: Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 6 [20]: CSeq: 49313 REGISTER [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 7 [27]: User-Agent: MicroSIP/3.3.27 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 8 [46]: Contact: “104” sip:104@192.168.1.200:5060;ob [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 9 [12]: Expires: 300 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 10 [96]: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 11 [17]: Content-Length: 0 [Mar 15 15:59:12] VERBOSE[15255] chan\_sip.c: — (12 headers 0 lines) — [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: = Looking for Call ID: dfdf1d529a3e419fa3a9a24356e893f3 (Checking From) --From tag df488cd5a2244656a86218d790a2f0cb --To-tag [Mar 15 15:59:12] DEBUG[15255] acl.c: For destination ‘$FIREWALL\_IP’, our source address is ‘$ASTERISK\_IP’. [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Setting SIP\_TRANSPORT\_UDP with address $ASTERISK\_IP:5060 [Mar 15 15:59:12] DEBUG[15255] netsock2.c: Splitting ‘192.168.1.200:5060’ into… [Mar 15 15:59:12] DEBUG[15255] netsock2.c: …host ‘192.168.1.200’ and port ‘5060’. [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: NAT detected for 192.168.1.200 / $FIREWALL\_IP [Mar 15 15:59:12] VERBOSE[15255] chan\_sip.c: Sending to $FIREWALL\_IP:5060 (NAT) [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Allocating new SIP dialog for dfdf1d529a3e419fa3a9a24356e893f3 - REGISTER (No RTP) [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: \*\*\*\* Received REGISTER (2) - Command in SIP REGISTER [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Initializing initreq for method REGISTER - callid dfdf1d529a3e419fa3a9a24356e893f3 [Mar 15 15:59:12] DEBUG[15255] netsock2.c: Splitting ‘192.168.1.200:5060’ into… [Mar 15 15:59:12] DEBUG[15255] netsock2.c: …host ‘192.168.1.200’ and port ‘5060’. [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: NAT detected for 192.168.1.200 / $FIREWALL\_IP [Mar 15 15:59:12] VERBOSE[15255] chan\_sip.c: Sending to $FIREWALL\_IP:5060 (NAT) [Mar 15 15:59:12] DEBUG[15255] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:59:12] DEBUG[15255] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:59:12] VERBOSE[15255] chan\_sip.c: \<— Transmitting (NAT) to $FIREWALL\_IP:5060 —\> SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.1.200:5060;branch=z9hG4bKPja2e51b8071484c84905a5a715cc02fd3;received=$FIREWALL\_IP;rport=5060 From: “104” sip:104@$ASTERISK\_IP;tag=df488cd5a2244656a86218d790a2f0cb To: “104” sip:104@$ASTERISK\_IP;tag=as3ac788dd Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 CSeq: 49313 REGISTER Server: Asterisk PBX 11.8.1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce="418f3f01" Content-Length: 0 \<------------\> [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 0 [24]: SIP/2.0 401 Unauthorized [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 1 [118]: Via: SIP/2.0/UDP 192.168.1.200:5060;branch=z9hG4bKPja2e51b8071484c84905a5a715cc02fd3;received=$FIREWALL\_IP;rport=5060 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 2 [72]: From: “104” sip:104@$ASTERISK\_IP;tag=df488cd5a2244656a86218d790a2f0cb [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 3 [48]: To: “104” sip:104@$ASTERISK\_IP;tag=as3ac788dd [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 4 [41]: Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 5 [20]: CSeq: 49313 REGISTER [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 6 [27]: Server: Asterisk PBX 11.8.1 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 7 [81]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 8 [26]: Supported: replaces, timer [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 9 [74]: WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce=“418f3f01” [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 10 [17]: Content-Length: 0 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 11 [0]: [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Trying to put ‘SIP/2.0 401’ onto UDP socket destined for $FIREWALL\_IP:5060 [Mar 15 15:59:12] VERBOSE[15255] chan\_sip.c: Scheduling destruction of SIP dialog ‘dfdf1d529a3e419fa3a9a24356e893f3’ in 32000 ms (Method: REGISTER) [Mar 15 15:59:12] VERBOSE[15255] chan\_sip.c: \<— SIP read from UDP:$FIREWALL\_IP:5060 —\> REGISTER sip:$ASTERISK\_IP SIP/2.0 Via: SIP/2.0/UDP 192.168.1.200:5060;rport;branch=z9hG4bKPjdf7dbccb03554ed19bce79c7cd38791e Max-Forwards: 70 From: “104” sip:104@$ASTERISK\_IP;tag=df488cd5a2244656a86218d790a2f0cb To: “104” sip:104@$ASTERISK\_IP Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 CSeq: 49314 REGISTER User-Agent: MicroSIP/3.3.27 Contact: “104” sip:104@192.168.1.200:5060;ob Expires: 300 Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Authorization: Digest username=“104”, realm=“asterisk”, nonce=“418f3f01”, uri=“sip:$ASTERISK\_IP”, response=“ddc07d5cee4283803d4951fce4c76c0b”, algorithm=MD5 Content-Length: 0 \<-------------\> [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 0 [34]: REGISTER sip:$ASTERISK\_IP SIP/2.0 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 1 [90]: Via: SIP/2.0/UDP 192.168.1.200:5060;rport;branch=z9hG4bKPjdf7dbccb03554ed19bce79c7cd38791e [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 2 [16]: Max-Forwards: 70 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 3 [72]: From: “104” sip:104@$ASTERISK\_IP;tag=df488cd5a2244656a86218d790a2f0cb [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 4 [33]: To: “104” sip:104@$ASTERISK\_IP [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 5 [41]: Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 6 [20]: CSeq: 49314 REGISTER [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 7 [27]: User-Agent: MicroSIP/3.3.27 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 8 [46]: Contact: “104” sip:104@192.168.1.200:5060;ob [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 9 [12]: Expires: 300 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 10 [96]: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, INFO, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 11 [157]: Authorization: Digest username=“104”, realm=“asterisk”, nonce=“418f3f01”, uri=“sip:$ASTERISK\_IP”, response=“ddc07d5cee4283803d4951fce4c76c0b”, algorithm=MD5 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 12 [17]: Content-Length: 0 [Mar 15 15:59:12] VERBOSE[15255] chan\_sip.c: — (13 headers 0 lines) — [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: = Looking for Call ID: dfdf1d529a3e419fa3a9a24356e893f3 (Checking From) --From tag df488cd5a2244656a86218d790a2f0cb --To-tag [Mar 15 15:59:12] DEBUG[15255] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:59:12] DEBUG[15255] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:59:12] DEBUG[15255] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:59:12] DEBUG[15255] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: \*\*\*\* Received REGISTER (2) - Command in SIP REGISTER [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Initializing initreq for method REGISTER - callid dfdf1d529a3e419fa3a9a24356e893f3 [Mar 15 15:59:12] DEBUG[15255] netsock2.c: Splitting ‘192.168.1.200:5060’ into… [Mar 15 15:59:12] DEBUG[15255] netsock2.c: …host ‘192.168.1.200’ and port ‘5060’. [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: NAT detected for 192.168.1.200 / $FIREWALL\_IP [Mar 15 15:59:12] VERBOSE[15255] chan\_sip.c: Sending to $FIREWALL\_IP:5060 (NAT) [Mar 15 15:59:12] DEBUG[15255] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:59:12] DEBUG[15255] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Store REGISTER’s src-IP:port for call routing. [Mar 15 15:59:12] VERBOSE[15255] chan\_sip.c: \<— Transmitting (NAT) to $FIREWALL\_IP:5060 —\> SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.1.200:5060;branch=z9hG4bKPjdf7dbccb03554ed19bce79c7cd38791e;received=$FIREWALL\_IP;rport=5060 From: “104” sip:104@$ASTERISK\_IP;tag=df488cd5a2244656a86218d790a2f0cb To: “104” sip:104@$ASTERISK\_IP;tag=as3ac788dd Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 CSeq: 49314 REGISTER Server: Asterisk PBX 11.8.1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Expires: 300 Contact: sip:104@192.168.1.200:5060;ob;expires=300 Date: Sat, 15 Mar 2014 11:59:12 GMT Content-Length: 0 \<------------\> [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 0 [14]: SIP/2.0 200 OK [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 1 [118]: Via: SIP/2.0/UDP 192.168.1.200:5060;branch=z9hG4bKPjdf7dbccb03554ed19bce79c7cd38791e;received=$FIREWALL\_IP;rport=5060 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 2 [72]: From: “104” sip:104@$ASTERISK\_IP;tag=df488cd5a2244656a86218d790a2f0cb [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 3 [48]: To: “104” sip:104@$ASTERISK\_IP;tag=as3ac788dd [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 4 [41]: Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 5 [20]: CSeq: 49314 REGISTER [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 6 [27]: Server: Asterisk PBX 11.8.1 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 7 [81]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 8 [26]: Supported: replaces, timer [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 9 [12]: Expires: 300 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 10 [52]: Contact: sip:104@192.168.1.200:5060;ob;expires=300 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 11 [35]: Date: Sat, 15 Mar 2014 11:59:12 GMT [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 12 [17]: Content-Length: 0 [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Header 13 [0]: [Mar 15 15:59:12] DEBUG[15255] chan\_sip.c: Trying to put ‘SIP/2.0 200’ onto UDP socket destined for $FIREWALL\_IP:5060 [Mar 15 15:59:12] VERBOSE[15255] chan\_sip.c: Scheduling destruction of SIP dialog ‘dfdf1d529a3e419fa3a9a24356e893f3’ in 32000 ms (Method: REGISTER) [Mar 15 15:59:12] DEBUG[15246] devicestate.c: No provider found, checking channel drivers for SIP - 104 [Mar 15 15:59:12] DEBUG[15246] chan\_sip.c: Checking device state for peer 104 [Mar 15 15:59:12] DEBUG[15246] devicestate.c: Changing state for SIP/104 - state 1 (Not in use) [Mar 15 15:59:12] DEBUG[15246] devicestate.c: device ‘SIP/104’ state ‘1’ [Mar 15 15:59:12] DEBUG[15280] app\_queue.c: Device ‘SIP/104’ changed to state ‘1’ (Not in use) but we don’t care because they’re not a member of any queue. [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: \<— SIP read from UDP:$FIREWALL\_IP:5060 —\> REGISTER sip:$ASTERISK\_IP SIP/2.0 Via: SIP/2.0/UDP 192.168.1.200:5060;rport;branch=z9hG4bKPj0251e91c0b3049e6985c2ee32945ffb2 Max-Forwards: 70 From: “104” sip:104@$ASTERISK\_IP;tag=a55dff0a91dc4b7ca75782be1165d376 To: “104” sip:104@$ASTERISK\_IP Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 CSeq: 49315 REGISTER User-Agent: MicroSIP/3.3.27 Contact: “104” sip:104@192.168.1.200:5060;ob Expires: 0 Content-Length: 0 \<-------------\> [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 0 [34]: REGISTER sip:$ASTERISK\_IP SIP/2.0 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 1 [90]: Via: SIP/2.0/UDP 192.168.1.200:5060;rport;branch=z9hG4bKPj0251e91c0b3049e6985c2ee32945ffb2 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 2 [16]: Max-Forwards: 70 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 3 [72]: From: “104” sip:104@$ASTERISK\_IP;tag=a55dff0a91dc4b7ca75782be1165d376 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 4 [33]: To: “104” sip:104@$ASTERISK\_IP [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 5 [41]: Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 6 [20]: CSeq: 49315 REGISTER [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 7 [27]: User-Agent: MicroSIP/3.3.27 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 8 [46]: Contact: “104” sip:104@192.168.1.200:5060;ob [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 9 [10]: Expires: 0 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 10 [17]: Content-Length: 0 [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: — (11 headers 0 lines) — [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: = Looking for Call ID: dfdf1d529a3e419fa3a9a24356e893f3 (Checking From) --From tag a55dff0a91dc4b7ca75782be1165d376 --To-tag [Mar 15 15:59:24] DEBUG[15255] acl.c: For destination ‘$FIREWALL\_IP’, our source address is ‘$ASTERISK\_IP’. [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Setting SIP\_TRANSPORT\_UDP with address $ASTERISK\_IP:5060 [Mar 15 15:59:24] DEBUG[15255] netsock2.c: Splitting ‘192.168.1.200:5060’ into… [Mar 15 15:59:24] DEBUG[15255] netsock2.c: …host ‘192.168.1.200’ and port ‘5060’. [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: NAT detected for 192.168.1.200 / $FIREWALL\_IP [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: Sending to $FIREWALL\_IP:5060 (NAT) [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Allocating new SIP dialog for dfdf1d529a3e419fa3a9a24356e893f3 - REGISTER (No RTP) [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: \*\*\*\* Received REGISTER (2) - Command in SIP REGISTER [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Initializing initreq for method REGISTER - callid dfdf1d529a3e419fa3a9a24356e893f3 [Mar 15 15:59:24] DEBUG[15255] netsock2.c: Splitting ‘192.168.1.200:5060’ into… [Mar 15 15:59:24] DEBUG[15255] netsock2.c: …host ‘192.168.1.200’ and port ‘5060’. [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: NAT detected for 192.168.1.200 / $FIREWALL\_IP [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: Sending to $FIREWALL\_IP:5060 (NAT) [Mar 15 15:59:24] DEBUG[15255] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:59:24] DEBUG[15255] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: \<— Transmitting (NAT) to $FIREWALL\_IP:5060 —\> SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.1.200:5060;branch=z9hG4bKPj0251e91c0b3049e6985c2ee32945ffb2;received=$FIREWALL\_IP;rport=5060 From: “104” sip:104@$ASTERISK\_IP;tag=a55dff0a91dc4b7ca75782be1165d376 To: “104” sip:104@$ASTERISK\_IP;tag=as4f9c93f6 Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 CSeq: 49315 REGISTER Server: Asterisk PBX 11.8.1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce="4f524dc6" Content-Length: 0 \<------------\> [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 0 [24]: SIP/2.0 401 Unauthorized [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 1 [118]: Via: SIP/2.0/UDP 192.168.1.200:5060;branch=z9hG4bKPj0251e91c0b3049e6985c2ee32945ffb2;received=$FIREWALL\_IP;rport=5060 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 2 [72]: From: “104” sip:104@$ASTERISK\_IP;tag=a55dff0a91dc4b7ca75782be1165d376 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 3 [48]: To: “104” sip:104@$ASTERISK\_IP;tag=as4f9c93f6 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 4 [41]: Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 5 [20]: CSeq: 49315 REGISTER [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 6 [27]: Server: Asterisk PBX 11.8.1 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 7 [81]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 8 [26]: Supported: replaces, timer [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 9 [74]: WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce=“4f524dc6” [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 10 [17]: Content-Length: 0 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 11 [0]: [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Trying to put ‘SIP/2.0 401’ onto UDP socket destined for $FIREWALL\_IP:5060 [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: Scheduling destruction of SIP dialog ‘dfdf1d529a3e419fa3a9a24356e893f3’ in 32000 ms (Method: REGISTER) [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: \<— SIP read from UDP:$FIREWALL\_IP:5060 —\> REGISTER sip:$ASTERISK\_IP SIP/2.0 Via: SIP/2.0/UDP 192.168.1.200:5060;rport;branch=z9hG4bKPj2b2826a455ec4132b9c39845cbaadafd Max-Forwards: 70 From: “104” sip:104@$ASTERISK\_IP;tag=a55dff0a91dc4b7ca75782be1165d376 To: “104” sip:104@$ASTERISK\_IP Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 CSeq: 49316 REGISTER User-Agent: MicroSIP/3.3.27 Contact: “104” sip:104@192.168.1.200:5060;ob Expires: 0 Authorization: Digest username=“104”, realm=“asterisk”, nonce=“4f524dc6”, uri=“sip:$ASTERISK\_IP”, response=“a11bc644390bd4f4a3d62f5de5439f1a”, algorithm=MD5 Content-Length: 0 \<-------------\> [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 0 [34]: REGISTER sip:$ASTERISK\_IP SIP/2.0 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 1 [90]: Via: SIP/2.0/UDP 192.168.1.200:5060;rport;branch=z9hG4bKPj2b2826a455ec4132b9c39845cbaadafd [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 2 [16]: Max-Forwards: 70 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 3 [72]: From: “104” sip:104@$ASTERISK\_IP;tag=a55dff0a91dc4b7ca75782be1165d376 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 4 [33]: To: “104” sip:104@$ASTERISK\_IP [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 5 [41]: Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 6 [20]: CSeq: 49316 REGISTER [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 7 [27]: User-Agent: MicroSIP/3.3.27 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 8 [46]: Contact: “104” sip:104@192.168.1.200:5060;ob [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 9 [10]: Expires: 0 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 10 [157]: Authorization: Digest username=“104”, realm=“asterisk”, nonce=“4f524dc6”, uri=“sip:$ASTERISK\_IP”, response=“a11bc644390bd4f4a3d62f5de5439f1a”, algorithm=MD5 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 11 [17]: Content-Length: 0 [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: — (12 headers 0 lines) — [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: = Looking for Call ID: dfdf1d529a3e419fa3a9a24356e893f3 (Checking From) --From tag a55dff0a91dc4b7ca75782be1165d376 --To-tag [Mar 15 15:59:24] DEBUG[15255] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:59:24] DEBUG[15255] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:59:24] DEBUG[15255] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:59:24] DEBUG[15255] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: \*\*\*\* Received REGISTER (2) - Command in SIP REGISTER [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Initializing initreq for method REGISTER - callid dfdf1d529a3e419fa3a9a24356e893f3 [Mar 15 15:59:24] DEBUG[15255] netsock2.c: Splitting ‘192.168.1.200:5060’ into… [Mar 15 15:59:24] DEBUG[15255] netsock2.c: …host ‘192.168.1.200’ and port ‘5060’. [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: NAT detected for 192.168.1.200 / $FIREWALL\_IP [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: Sending to $FIREWALL\_IP:5060 (NAT) [Mar 15 15:59:24] DEBUG[15255] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:59:24] DEBUG[15255] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:59:24] NOTICE[15255] chan\_sip.c: Correct auth, but based on stale nonce received from ‘“104” sip:104@$ASTERISK\_IP;tag=a55dff0a91dc4b7ca75782be1165d376’ [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: \<— Transmitting (NAT) to $FIREWALL\_IP:5060 —\> SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.1.200:5060;branch=z9hG4bKPj2b2826a455ec4132b9c39845cbaadafd;received=$FIREWALL\_IP;rport=5060 From: “104” sip:104@$ASTERISK\_IP;tag=a55dff0a91dc4b7ca75782be1165d376 To: “104” sip:104@$ASTERISK\_IP;tag=as3ac788dd Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 CSeq: 49316 REGISTER Server: Asterisk PBX 11.8.1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce=“7ee251f3”, stale=true Content-Length: 0 \<------------\> [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 0 [24]: SIP/2.0 401 Unauthorized [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 1 [118]: Via: SIP/2.0/UDP 192.168.1.200:5060;branch=z9hG4bKPj2b2826a455ec4132b9c39845cbaadafd;received=$FIREWALL\_IP;rport=5060 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 2 [72]: From: “104” sip:104@$ASTERISK\_IP;tag=a55dff0a91dc4b7ca75782be1165d376 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 3 [48]: To: “104” sip:104@$ASTERISK\_IP;tag=as3ac788dd [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 4 [41]: Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 5 [20]: CSeq: 49316 REGISTER [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 6 [27]: Server: Asterisk PBX 11.8.1 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 7 [81]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 8 [26]: Supported: replaces, timer [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 9 [86]: WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce=“7ee251f3”, stale=true [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 10 [17]: Content-Length: 0 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 11 [0]: [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Trying to put ‘SIP/2.0 401’ onto UDP socket destined for $FIREWALL\_IP:5060 [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: Scheduling destruction of SIP dialog ‘dfdf1d529a3e419fa3a9a24356e893f3’ in 32000 ms (Method: REGISTER) [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: \<— SIP read from UDP:$FIREWALL\_IP:5060 —\> REGISTER sip:$ASTERISK\_IP SIP/2.0 Via: SIP/2.0/UDP 192.168.1.200:5060;rport;branch=z9hG4bKPje371697f711649aa9b437ac3dd739b59 Max-Forwards: 70 From: “104” sip:104@$ASTERISK\_IP;tag=a55dff0a91dc4b7ca75782be1165d376 To: “104” sip:104@$ASTERISK\_IP Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 CSeq: 49317 REGISTER User-Agent: MicroSIP/3.3.27 Contact: “104” sip:104@192.168.1.200:5060;ob Expires: 0 Authorization: Digest username=“104”, realm=“asterisk”, nonce=“7ee251f3”, uri=“sip:$ASTERISK\_IP”, response=“2b6b4f1f324072ee02defad77abdd3f4”, algorithm=MD5 Content-Length: 0 \<-------------\> [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 0 [34]: REGISTER sip:$ASTERISK\_IP SIP/2.0 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 1 [90]: Via: SIP/2.0/UDP 192.168.1.200:5060;rport;branch=z9hG4bKPje371697f711649aa9b437ac3dd739b59 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 2 [16]: Max-Forwards: 70 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 3 [72]: From: “104” sip:104@$ASTERISK\_IP;tag=a55dff0a91dc4b7ca75782be1165d376 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 4 [33]: To: “104” sip:104@$ASTERISK\_IP [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 5 [41]: Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 6 [20]: CSeq: 49317 REGISTER [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 7 [27]: User-Agent: MicroSIP/3.3.27 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 8 [46]: Contact: “104” sip:104@192.168.1.200:5060;ob [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 9 [10]: Expires: 0 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 10 [157]: Authorization: Digest username=“104”, realm=“asterisk”, nonce=“7ee251f3”, uri=“sip:$ASTERISK\_IP”, response=“2b6b4f1f324072ee02defad77abdd3f4”, algorithm=MD5 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 11 [17]: Content-Length: 0 [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: — (12 headers 0 lines) — [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: = Looking for Call ID: dfdf1d529a3e419fa3a9a24356e893f3 (Checking From) --From tag a55dff0a91dc4b7ca75782be1165d376 --To-tag [Mar 15 15:59:24] DEBUG[15255] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:59:24] DEBUG[15255] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:59:24] DEBUG[15255] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:59:24] DEBUG[15255] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: \*\*\*\* Received REGISTER (2) - Command in SIP REGISTER [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Initializing initreq for method REGISTER - callid dfdf1d529a3e419fa3a9a24356e893f3 [Mar 15 15:59:24] DEBUG[15255] netsock2.c: Splitting ‘192.168.1.200:5060’ into… [Mar 15 15:59:24] DEBUG[15255] netsock2.c: …host ‘192.168.1.200’ and port ‘5060’. [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: NAT detected for 192.168.1.200 / $FIREWALL\_IP [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: Sending to $FIREWALL\_IP:5060 (NAT) [Mar 15 15:59:24] DEBUG[15255] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:59:24] DEBUG[15255] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: \<— Transmitting (NAT) to $FIREWALL\_IP:5060 —\> SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.1.200:5060;branch=z9hG4bKPje371697f711649aa9b437ac3dd739b59;received=$FIREWALL\_IP;rport=5060 From: “104” sip:104@$ASTERISK\_IP;tag=a55dff0a91dc4b7ca75782be1165d376 To: “104” sip:104@$ASTERISK\_IP;tag=as3ac788dd Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 CSeq: 49317 REGISTER Server: Asterisk PBX 11.8.1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Expires: 0 Date: Sat, 15 Mar 2014 11:59:24 GMT Content-Length: 0 \<------------\> [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 0 [14]: SIP/2.0 200 OK [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 1 [118]: Via: SIP/2.0/UDP 192.168.1.200:5060;branch=z9hG4bKPje371697f711649aa9b437ac3dd739b59;received=$FIREWALL\_IP;rport=5060 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 2 [72]: From: “104” sip:104@$ASTERISK\_IP;tag=a55dff0a91dc4b7ca75782be1165d376 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 3 [48]: To: “104” sip:104@$ASTERISK\_IP;tag=as3ac788dd [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 4 [41]: Call-ID: dfdf1d529a3e419fa3a9a24356e893f3 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 5 [20]: CSeq: 49317 REGISTER [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 6 [27]: Server: Asterisk PBX 11.8.1 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 7 [81]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 8 [26]: Supported: replaces, timer [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 9 [10]: Expires: 0 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 10 [35]: Date: Sat, 15 Mar 2014 11:59:24 GMT [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 11 [17]: Content-Length: 0 [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Header 12 [0]: [Mar 15 15:59:24] DEBUG[15255] chan\_sip.c: Trying to put ‘SIP/2.0 200’ onto UDP socket destined for $FIREWALL\_IP:5060 [Mar 15 15:59:24] DEBUG[15246] devicestate.c: No provider found, checking channel drivers for SIP - 104 [Mar 15 15:59:24] DEBUG[15246] chan\_sip.c: Checking device state for peer 104 [Mar 15 15:59:24] VERBOSE[15255] chan\_sip.c: Scheduling destruction of SIP dialog ‘dfdf1d529a3e419fa3a9a24356e893f3’ in 32000 ms (Method: REGISTER) [Mar 15 15:59:24] DEBUG[15246] devicestate.c: Changing state for SIP/104 - state 5 (Unavailable) [Mar 15 15:59:24] DEBUG[15246] devicestate.c: device ‘SIP/104’ state ‘5’ [Mar 15 15:59:24] DEBUG[15246] devicestate.c: No provider found, checking channel drivers for SIP - 104 [Mar 15 15:59:24] DEBUG[15246] chan\_sip.c: Checking device state for peer 104 [Mar 15 15:59:24] DEBUG[15246] devicestate.c: Changing state for SIP/104 - state 5 (Unavailable) [Mar 15 15:59:24] DEBUG[15246] devicestate.c: device ‘SIP/104’ state ‘5’ [Mar 15 15:59:24] DEBUG[15280] app\_queue.c: Device ‘SIP/104’ changed to state ‘5’ (Unavailable) but we don’t care because they’re not a member of any queue. [Mar 15 15:59:24] DEBUG[15280] app\_queue.c: Device ‘SIP/104’ changed to state ‘5’ (Unavailable) but we don’t care because they’re not a member of any queue. [Mar 15 15:59:29] DEBUG[15214] taskprocessor.c: destroying taskprocessor ‘ast\_msg\_queue’ [Mar 15 15:59:29] VERBOSE[15214] asterisk.c: Asterisk cleanly ending (0). [Mar 15 15:59:29] VERBOSE[15214] asterisk.c: Executing last minute cleanups [/code] ---
**Author:** ![beaver\_rrr](https://sea1.discourse-cdn.com/asterisk/user_avatar/community.asterisk.org/beaver_rrr/32/228_2.png) [@beaver\_rrr](https://community.asterisk.org/u/beaver_rrr)\ **Post date:** [March 15, 2014, 12:18pm UTC](https://community.asterisk.org/t/sip-cliend-behind-nat-cant-connect/45558/3 "2014-03-15T12:18:44Z")
And this one for 103, which does not: [code][Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: \<— SIP read from UDP:$FIREWALL\_IP:5066 —\> REGISTER sip:$ASTERISK\_IP;transport=udp SIP/2.0 Via: SIP/2.0/UDP 192.168.1.54:5066;rport;branch=z9hG4bKPjMzUeOUrmchT42uKCxCHdnc75RwKf0PbU;alias Max-Forwards: 70 From: sip:103@$ASTERISK\_IP;tag=kZDteQEvs.iKt4rfbyvocIDYJc8SyadP To: sip:103@$ASTERISK\_IP Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 CSeq: 59791 REGISTER User-Agent: Konftel300IP 2.2.9 Contact: sip:103@192.168.1.54:5066;ob Expires: 1800 Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Content-Length: 0 \<-------------\> [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 0 [48]: REGISTER sip:$ASTERISK\_IP;transport=udp SIP/2.0 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 1 [95]: Via: SIP/2.0/UDP 192.168.1.54:5066;rport;branch=z9hG4bKPjMzUeOUrmchT42uKCxCHdnc75RwKf0PbU;alias [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 2 [16]: Max-Forwards: 70 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 3 [66]: From: sip:103@$ASTERISK\_IP;tag=kZDteQEvs.iKt4rfbyvocIDYJc8SyadP [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 4 [27]: To: sip:103@$ASTERISK\_IP [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 5 [41]: Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 6 [20]: CSeq: 59791 REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 7 [30]: User-Agent: Konftel300IP 2.2.9 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 8 [39]: Contact: sip:103@192.168.1.54:5066;ob [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 9 [13]: Expires: 1800 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 10 [90]: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 11 [17]: Content-Length: 0 [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: — (12 headers 0 lines) — [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: = Looking for Call ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 (Checking From) --From tag kZDteQEvs.iKt4rfbyvocIDYJc8SyadP --To-tag [Mar 15 15:54:21] DEBUG[15103] acl.c: For destination ‘$FIREWALL\_IP’, our source address is ‘$ASTERISK\_IP’. [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Setting SIP\_TRANSPORT\_UDP with address $ASTERISK\_IP:5060 [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘192.168.1.54:5066’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘192.168.1.54’ and port ‘5066’. [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: NAT detected for 192.168.1.54 / $FIREWALL\_IP [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: Sending to $FIREWALL\_IP:5066 (NAT) [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Allocating new SIP dialog for PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 - REGISTER (No RTP) [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: \*\*\*\* Received REGISTER (2) - Command in SIP REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Initializing initreq for method REGISTER - callid PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘192.168.1.54:5066’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘192.168.1.54’ and port ‘5066’. [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: NAT detected for 192.168.1.54 / $FIREWALL\_IP [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: Sending to $FIREWALL\_IP:5066 (NAT) [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: \<— Transmitting (NAT) to $FIREWALL\_IP:5066 —\> SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.1.54:5066;branch=z9hG4bKPjMzUeOUrmchT42uKCxCHdnc75RwKf0PbU;alias;received=$FIREWALL\_IP;rport=5066 From: sip:103@$ASTERISK\_IP;tag=kZDteQEvs.iKt4rfbyvocIDYJc8SyadP To: sip:103@$ASTERISK\_IP;tag=as41535b92 Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 CSeq: 59791 REGISTER Server: Asterisk PBX 11.8.1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce="2ff9e103" Content-Length: 0 \<------------\> [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 0 [24]: SIP/2.0 401 Unauthorized [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 1 [123]: Via: SIP/2.0/UDP 192.168.1.54:5066;branch=z9hG4bKPjMzUeOUrmchT42uKCxCHdnc75RwKf0PbU;alias;received=$FIREWALL\_IP;rport=5066 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 2 [66]: From: sip:103@$ASTERISK\_IP;tag=kZDteQEvs.iKt4rfbyvocIDYJc8SyadP [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 3 [42]: To: sip:103@$ASTERISK\_IP;tag=as41535b92 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 4 [41]: Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 5 [20]: CSeq: 59791 REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 6 [27]: Server: Asterisk PBX 11.8.1 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 7 [81]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 8 [26]: Supported: replaces, timer [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 9 [74]: WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce=“2ff9e103” [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 10 [17]: Content-Length: 0 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 11 [0]: [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Trying to put ‘SIP/2.0 401’ onto UDP socket destined for $FIREWALL\_IP:5066 [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: Scheduling destruction of SIP dialog ‘PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6’ in 32000 ms (Method: REGISTER) [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: \<— SIP read from UDP:$FIREWALL\_IP:5066 —\> REGISTER sip:$ASTERISK\_IP;transport=udp SIP/2.0 Via: SIP/2.0/UDP 192.168.1.54:5066;rport;branch=z9hG4bKPjt5EFKOK4RvdrAhys4eHvbPLLmM6Uua5K;alias Max-Forwards: 70 From: sip:103@$ASTERISK\_IP;tag=kZDteQEvs.iKt4rfbyvocIDYJc8SyadP To: sip:103@$ASTERISK\_IP Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 CSeq: 59792 REGISTER User-Agent: Konftel300IP 2.2.9 Contact: sip:103@192.168.1.54:5066;ob Expires: 1800 Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Authorization: Digest username=“103”, realm=“asterisk”, nonce=“2ff9e103”, uri=“sip:$ASTERISK\_IP;transport=udp”, response=“83657684f17b92592ff00d24d3e68777”, algorithm=MD5 Content-Length: 0 \<-------------\> [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 0 [48]: REGISTER sip:$ASTERISK\_IP;transport=udp SIP/2.0 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 1 [95]: Via: SIP/2.0/UDP 192.168.1.54:5066;rport;branch=z9hG4bKPjt5EFKOK4RvdrAhys4eHvbPLLmM6Uua5K;alias [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 2 [16]: Max-Forwards: 70 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 3 [66]: From: sip:103@$ASTERISK\_IP;tag=kZDteQEvs.iKt4rfbyvocIDYJc8SyadP [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 4 [27]: To: sip:103@$ASTERISK\_IP [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 5 [41]: Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 6 [20]: CSeq: 59792 REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 7 [30]: User-Agent: Konftel300IP 2.2.9 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 8 [39]: Contact: sip:103@192.168.1.54:5066;ob [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 9 [13]: Expires: 1800 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 10 [90]: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 11 [171]: Authorization: Digest username=“103”, realm=“asterisk”, nonce=“2ff9e103”, uri=“sip:$ASTERISK\_IP;transport=udp”, response=“83657684f17b92592ff00d24d3e68777”, algorithm=MD5 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 12 [17]: Content-Length: 0 [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: — (13 headers 0 lines) — [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: = Looking for Call ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 (Checking From) --From tag kZDteQEvs.iKt4rfbyvocIDYJc8SyadP --To-tag [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: \*\*\*\* Received REGISTER (2) - Command in SIP REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Initializing initreq for method REGISTER - callid PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘192.168.1.54:5066’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘192.168.1.54’ and port ‘5066’. [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: NAT detected for 192.168.1.54 / $FIREWALL\_IP [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: Sending to $FIREWALL\_IP:5066 (NAT) [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Store REGISTER’s src-IP:port for call routing. [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: \<— Transmitting (NAT) to $FIREWALL\_IP:5066 —\> SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.1.54:5066;branch=z9hG4bKPjt5EFKOK4RvdrAhys4eHvbPLLmM6Uua5K;alias;received=$FIREWALL\_IP;rport=5066 From: sip:103@$ASTERISK\_IP;tag=kZDteQEvs.iKt4rfbyvocIDYJc8SyadP To: sip:103@$ASTERISK\_IP;tag=as41535b92 Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 CSeq: 59792 REGISTER Server: Asterisk PBX 11.8.1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Expires: 1800 Contact: sip:103@192.168.1.54:5066;ob;expires=1800 Date: Sat, 15 Mar 2014 11:54:21 GMT Content-Length: 0 \<------------\> [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 0 [14]: SIP/2.0 200 OK [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 1 [123]: Via: SIP/2.0/UDP 192.168.1.54:5066;branch=z9hG4bKPjt5EFKOK4RvdrAhys4eHvbPLLmM6Uua5K;alias;received=$FIREWALL\_IP;rport=5066 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 2 [66]: From: sip:103@$ASTERISK\_IP;tag=kZDteQEvs.iKt4rfbyvocIDYJc8SyadP [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 3 [42]: To: sip:103@$ASTERISK\_IP;tag=as41535b92 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 4 [41]: Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 5 [20]: CSeq: 59792 REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 6 [27]: Server: Asterisk PBX 11.8.1 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 7 [81]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 8 [26]: Supported: replaces, timer [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 9 [13]: Expires: 1800 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 10 [52]: Contact: sip:103@192.168.1.54:5066;ob;expires=1800 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 11 [35]: Date: Sat, 15 Mar 2014 11:54:21 GMT [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 12 [17]: Content-Length: 0 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 13 [0]: [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Trying to put ‘SIP/2.0 200’ onto UDP socket destined for $FIREWALL\_IP:5066 [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: Scheduling destruction of SIP dialog ‘PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6’ in 32000 ms (Method: REGISTER) [Mar 15 15:54:21] DEBUG[15094] devicestate.c: No provider found, checking channel drivers for SIP - 103 [Mar 15 15:54:21] DEBUG[15094] chan\_sip.c: Checking device state for peer 103 [Mar 15 15:54:21] DEBUG[15094] devicestate.c: Changing state for SIP/103 - state 1 (Not in use) [Mar 15 15:54:21] DEBUG[15094] devicestate.c: device ‘SIP/103’ state ‘1’ [Mar 15 15:54:21] DEBUG[15128] app\_queue.c: Device ‘SIP/103’ changed to state ‘1’ (Not in use) but we don’t care because they’re not a member of any queue. [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: \<— SIP read from UDP:$FIREWALL\_IP:5066 —\> REGISTER sip:$ASTERISK\_IP;transport=udp SIP/2.0 Via: SIP/2.0/UDP 192.168.1.54:5066;rport;branch=z9hG4bKPjKfOFYib8x17U6wzfLOEKkV3aiED.9PfH;alias Max-Forwards: 70 From: sip:103@$ASTERISK\_IP;tag=y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg To: sip:103@$ASTERISK\_IP Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 CSeq: 59793 REGISTER User-Agent: Konftel300IP 2.2.9 Contact: sip:103@192.168.1.54:5066;ob Expires: 0 Content-Length: 0 \<-------------\> [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 0 [48]: REGISTER sip:$ASTERISK\_IP;transport=udp SIP/2.0 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 1 [95]: Via: SIP/2.0/UDP 192.168.1.54:5066;rport;branch=z9hG4bKPjKfOFYib8x17U6wzfLOEKkV3aiED.9PfH;alias [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 2 [16]: Max-Forwards: 70 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 3 [66]: From: sip:103@$ASTERISK\_IP;tag=y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 4 [27]: To: sip:103@$ASTERISK\_IP [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 5 [41]: Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 6 [20]: CSeq: 59793 REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 7 [30]: User-Agent: Konftel300IP 2.2.9 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 8 [39]: Contact: sip:103@192.168.1.54:5066;ob [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 9 [10]: Expires: 0 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 10 [17]: Content-Length: 0 [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: — (11 headers 0 lines) — [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: = Looking for Call ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 (Checking From) --From tag y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg --To-tag [Mar 15 15:54:21] DEBUG[15103] acl.c: For destination ‘$FIREWALL\_IP’, our source address is ‘$ASTERISK\_IP’. [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Setting SIP\_TRANSPORT\_UDP with address $ASTERISK\_IP:5060 [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘192.168.1.54:5066’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘192.168.1.54’ and port ‘5066’. [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: NAT detected for 192.168.1.54 / $FIREWALL\_IP [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: Sending to $FIREWALL\_IP:5066 (NAT) [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Allocating new SIP dialog for PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 - REGISTER (No RTP) [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: \*\*\*\* Received REGISTER (2) - Command in SIP REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Initializing initreq for method REGISTER - callid PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘192.168.1.54:5066’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘192.168.1.54’ and port ‘5066’. [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: NAT detected for 192.168.1.54 / $FIREWALL\_IP [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: Sending to $FIREWALL\_IP:5066 (NAT) [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: \<— Transmitting (NAT) to $FIREWALL\_IP:5066 —\> SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP 192.168.1.54:5066;branch=z9hG4bKPjKfOFYib8x17U6wzfLOEKkV3aiED.9PfH;alias;received=$FIREWALL\_IP;rport=5066 From: sip:103@$ASTERISK\_IP;tag=y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg To: sip:103@$ASTERISK\_IP;tag=as5c359725 Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 CSeq: 59793 REGISTER Server: Asterisk PBX 11.8.1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce="69986e44" Content-Length: 0 \<------------\> [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 0 [24]: SIP/2.0 401 Unauthorized [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 1 [123]: Via: SIP/2.0/UDP 192.168.1.54:5066;branch=z9hG4bKPjKfOFYib8x17U6wzfLOEKkV3aiED.9PfH;alias;received=$FIREWALL\_IP;rport=5066 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 2 [66]: From: sip:103@$ASTERISK\_IP;tag=y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 3 [42]: To: sip:103@$ASTERISK\_IP;tag=as5c359725 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 4 [41]: Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 5 [20]: CSeq: 59793 REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 6 [27]: Server: Asterisk PBX 11.8.1 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 7 [81]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 8 [26]: Supported: replaces, timer [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 9 [74]: WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce=“69986e44” [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 10 [17]: Content-Length: 0 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 11 [0]: [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Trying to put ‘SIP/2.0 401’ onto UDP socket destined for $FIREWALL\_IP:5066 [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: Scheduling destruction of SIP dialog ‘PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6’ in 32000 ms (Method: REGISTER) [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: \<— SIP read from UDP:$FIREWALL\_IP:5066 —\> REGISTER sip:$ASTERISK\_IP;transport=udp SIP/2.0 Via: SIP/2.0/UDP $FIREWALL\_IP:5066;rport;branch=z9hG4bKPjNXvMWYqKtTWkz1xfUYxvbWW7dZ0Snpnl;alias Max-Forwards: 70 From: sip:103@$ASTERISK\_IP;tag=EM.0nmIg6wlwzZHg.Q07UPdq9T82zo5j To: sip:103@$ASTERISK\_IP Call-ID: QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW CSeq: 52501 REGISTER User-Agent: Konftel300IP 2.2.9 Contact: sip:103@:5066$FIREWALL\_IP;transport=UDP;ob Expires: 1800 Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Content-Length: 0 \<-------------\> [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 0 [48]: REGISTER sip:$ASTERISK\_IP;transport=udp SIP/2.0 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 1 [96]: Via: SIP/2.0/UDP $FIREWALL\_IP:5066;rport;branch=z9hG4bKPjNXvMWYqKtTWkz1xfUYxvbWW7dZ0Snpnl;alias [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 2 [16]: Max-Forwards: 70 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 3 [66]: From: sip:103@$ASTERISK\_IP;tag=EM.0nmIg6wlwzZHg.Q07UPdq9T82zo5j [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 4 [27]: To: sip:103@$ASTERISK\_IP [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 5 [41]: Call-ID: QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 6 [20]: CSeq: 52501 REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 7 [30]: User-Agent: Konftel300IP 2.2.9 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 8 [54]: Contact: sip:103@:5066$FIREWALL\_IP;transport=UDP;ob [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 9 [13]: Expires: 1800 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 10 [90]: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 11 [17]: Content-Length: 0 [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: — (12 headers 0 lines) — [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: = Looking for Call ID: QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW (Checking From) --From tag EM.0nmIg6wlwzZHg.Q07UPdq9T82zo5j --To-tag [Mar 15 15:54:21] DEBUG[15103] acl.c: For destination ‘$FIREWALL\_IP’, our source address is ‘$ASTERISK\_IP’. [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Setting SIP\_TRANSPORT\_UDP with address $ASTERISK\_IP:5060 [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$FIREWALL\_IP:5066’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$FIREWALL\_IP’ and port ‘5066’. [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: Sending to $FIREWALL\_IP:5066 (no NAT) [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Allocating new SIP dialog for QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW - REGISTER (No RTP) [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: \*\*\*\* Received REGISTER (2) - Command in SIP REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Initializing initreq for method REGISTER - callid QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$FIREWALL\_IP:5066’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$FIREWALL\_IP’ and port ‘5066’. [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: Sending to $FIREWALL\_IP:5066 (no NAT) [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: \<— Transmitting (NAT) to $FIREWALL\_IP:5066 —\> SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP $FIREWALL\_IP:5066;branch=z9hG4bKPjNXvMWYqKtTWkz1xfUYxvbWW7dZ0Snpnl;alias;received=$FIREWALL\_IP;rport=5066 From: sip:103@$ASTERISK\_IP;tag=EM.0nmIg6wlwzZHg.Q07UPdq9T82zo5j To: sip:103@$ASTERISK\_IP;tag=as6489bd6a Call-ID: QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW CSeq: 52501 REGISTER Server: Asterisk PBX 11.8.1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce="0ee33ba6" Content-Length: 0 \<------------\> [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 0 [24]: SIP/2.0 401 Unauthorized [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 1 [124]: Via: SIP/2.0/UDP $FIREWALL\_IP:5066;branch=z9hG4bKPjNXvMWYqKtTWkz1xfUYxvbWW7dZ0Snpnl;alias;received=$FIREWALL\_IP;rport=5066 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 2 [66]: From: sip:103@$ASTERISK\_IP;tag=EM.0nmIg6wlwzZHg.Q07UPdq9T82zo5j [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 3 [42]: To: sip:103@$ASTERISK\_IP;tag=as6489bd6a [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 4 [41]: Call-ID: QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 5 [20]: CSeq: 52501 REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 6 [27]: Server: Asterisk PBX 11.8.1 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 7 [81]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 8 [26]: Supported: replaces, timer [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 9 [74]: WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce=“0ee33ba6” [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 10 [17]: Content-Length: 0 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 11 [0]: [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Trying to put ‘SIP/2.0 401’ onto UDP socket destined for $FIREWALL\_IP:5066 [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: Scheduling destruction of SIP dialog ‘QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW’ in 32000 ms (Method: REGISTER) [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: \<— SIP read from UDP:$FIREWALL\_IP:5066 —\> REGISTER sip:$ASTERISK\_IP;transport=udp SIP/2.0 Via: SIP/2.0/UDP $FIREWALL\_IP:5066;rport;branch=z9hG4bKPj.S8a.W6NP1zvlYprzzfnXG5RjoVZA92l;alias Max-Forwards: 70 From: sip:103@$ASTERISK\_IP;tag=y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg To: sip:103@$ASTERISK\_IP Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 CSeq: 59794 REGISTER User-Agent: Konftel300IP 2.2.9 Contact: sip:103@192.168.1.54:5066;ob Expires: 0 Authorization: Digest username=“103”, realm=“asterisk”, nonce=“69986e44”, uri=“sip:$ASTERISK\_IP;transport=udp”, response=“b19ac8661fbef8a01b9cfe6a577f8bcb”, algorithm=MD5 Content-Length: 0 \<-------------\> [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 0 [48]: REGISTER sip:$ASTERISK\_IP;transport=udp SIP/2.0 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 1 [96]: Via: SIP/2.0/UDP $FIREWALL\_IP:5066;rport;branch=z9hG4bKPj.S8a.W6NP1zvlYprzzfnXG5RjoVZA92l;alias [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 2 [16]: Max-Forwards: 70 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 3 [66]: From: sip:103@$ASTERISK\_IP;tag=y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 4 [27]: To: sip:103@$ASTERISK\_IP [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 5 [41]: Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 6 [20]: CSeq: 59794 REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 7 [30]: User-Agent: Konftel300IP 2.2.9 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 8 [39]: Contact: sip:103@192.168.1.54:5066;ob [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 9 [10]: Expires: 0 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 10 [171]: Authorization: Digest username=“103”, realm=“asterisk”, nonce=“69986e44”, uri=“sip:$ASTERISK\_IP;transport=udp”, response=“b19ac8661fbef8a01b9cfe6a577f8bcb”, algorithm=MD5 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 11 [17]: Content-Length: 0 [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: — (12 headers 0 lines) — [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: = Looking for Call ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 (Checking From) --From tag y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg --To-tag [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: \*\*\*\* Received REGISTER (2) - Command in SIP REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Initializing initreq for method REGISTER - callid PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$FIREWALL\_IP:5066’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$FIREWALL\_IP’ and port ‘5066’. [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: Sending to $FIREWALL\_IP:5066 (no NAT) [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:54:21] NOTICE[15103] chan\_sip.c: Correct auth, but based on stale nonce received from ‘sip:103@$ASTERISK\_IP;tag=y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg’ [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: \<— Transmitting (NAT) to $FIREWALL\_IP:5066 —\> SIP/2.0 401 Unauthorized Via: SIP/2.0/UDP $FIREWALL\_IP:5066;branch=z9hG4bKPj.S8a.W6NP1zvlYprzzfnXG5RjoVZA92l;alias;received=$FIREWALL\_IP;rport=5066 From: sip:103@$ASTERISK\_IP;tag=y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg To: sip:103@$ASTERISK\_IP;tag=as41535b92 Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 CSeq: 59794 REGISTER Server: Asterisk PBX 11.8.1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce=“42318b42”, stale=true Content-Length: 0 \<------------\> [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 0 [24]: SIP/2.0 401 Unauthorized [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 1 [124]: Via: SIP/2.0/UDP $FIREWALL\_IP:5066;branch=z9hG4bKPj.S8a.W6NP1zvlYprzzfnXG5RjoVZA92l;alias;received=$FIREWALL\_IP;rport=5066 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 2 [66]: From: sip:103@$ASTERISK\_IP;tag=y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 3 [42]: To: sip:103@$ASTERISK\_IP;tag=as41535b92 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 4 [41]: Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 5 [20]: CSeq: 59794 REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 6 [27]: Server: Asterisk PBX 11.8.1 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 7 [81]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 8 [26]: Supported: replaces, timer [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 9 [86]: WWW-Authenticate: Digest algorithm=MD5, realm=“asterisk”, nonce=“42318b42”, stale=true [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 10 [17]: Content-Length: 0 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 11 [0]: [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Trying to put ‘SIP/2.0 401’ onto UDP socket destined for $FIREWALL\_IP:5066 [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: Scheduling destruction of SIP dialog ‘PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6’ in 32000 ms (Method: REGISTER) [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: \<— SIP read from UDP:$FIREWALL\_IP:5066 —\> REGISTER sip:$ASTERISK\_IP;transport=udp SIP/2.0 Via: SIP/2.0/UDP $FIREWALL\_IP:5066;rport;branch=z9hG4bKPjqL34R.IeymP0EoRJLvlkNnuTLB9bGDlz;alias Max-Forwards: 70 From: sip:103@$ASTERISK\_IP;tag=EM.0nmIg6wlwzZHg.Q07UPdq9T82zo5j To: sip:103@$ASTERISK\_IP Call-ID: QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW CSeq: 52502 REGISTER User-Agent: Konftel300IP 2.2.9 Contact: sip:103@:5066$FIREWALL\_IP;transport=UDP;ob Expires: 1800 Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS Authorization: Digest username=“103”, realm=“asterisk”, nonce=“0ee33ba6”, uri=“sip:$ASTERISK\_IP;transport=udp”, response=“abd0356a0d81dc690069ed883d1ec84b”, algorithm=MD5 Content-Length: 0 \<-------------\> [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 0 [48]: REGISTER sip:$ASTERISK\_IP;transport=udp SIP/2.0 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 1 [96]: Via: SIP/2.0/UDP $FIREWALL\_IP:5066;rport;branch=z9hG4bKPjqL34R.IeymP0EoRJLvlkNnuTLB9bGDlz;alias [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 2 [16]: Max-Forwards: 70 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 3 [66]: From: sip:103@$ASTERISK\_IP;tag=EM.0nmIg6wlwzZHg.Q07UPdq9T82zo5j [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 4 [27]: To: sip:103@$ASTERISK\_IP [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 5 [41]: Call-ID: QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 6 [20]: CSeq: 52502 REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 7 [30]: User-Agent: Konftel300IP 2.2.9 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 8 [54]: Contact: sip:103@:5066$FIREWALL\_IP;transport=UDP;ob [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 9 [13]: Expires: 1800 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 10 [90]: Allow: PRACK, INVITE, ACK, BYE, CANCEL, UPDATE, SUBSCRIBE, NOTIFY, REFER, MESSAGE, OPTIONS [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 11 [171]: Authorization: Digest username=“103”, realm=“asterisk”, nonce=“0ee33ba6”, uri=“sip:$ASTERISK\_IP;transport=udp”, response=“abd0356a0d81dc690069ed883d1ec84b”, algorithm=MD5 [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Header 12 [17]: Content-Length: 0 [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: — (13 headers 0 lines) — [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: = Looking for Call ID: QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW (Checking From) --From tag EM.0nmIg6wlwzZHg.Q07UPdq9T82zo5j --To-tag [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: \*\*\*\* Received REGISTER (2) - Command in SIP REGISTER [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Initializing initreq for method REGISTER - callid QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$FIREWALL\_IP:5066’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$FIREWALL\_IP’ and port ‘5066’. [Mar 15 15:54:21] VERBOSE[15103] chan\_sip.c: Sending to $FIREWALL\_IP:5066 (no NAT) [Mar 15 15:54:21] DEBUG[15103] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:54:21] DEBUG[15103] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:54:21] DEBUG[15103] chan\_sip.c: Store REGISTER’s src-IP:port for call routing. [Mar 15 15:54:22] VERBOSE[15103] chan\_sip.c: \<— Transmitting (NAT) to $FIREWALL\_IP:5066 —\> SIP/2.0 200 OK Via: SIP/2.0/UDP $FIREWALL\_IP:5066;branch=z9hG4bKPjqL34R.IeymP0EoRJLvlkNnuTLB9bGDlz;alias;received=$FIREWALL\_IP;rport=5066 From: sip:103@$ASTERISK\_IP;tag=EM.0nmIg6wlwzZHg.Q07UPdq9T82zo5j To: sip:103@$ASTERISK\_IP;tag=as6489bd6a Call-ID: QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW CSeq: 52502 REGISTER Server: Asterisk PBX 11.8.1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Expires: 1800 Contact: sip:103@:5066$FIREWALL\_IP;transport=UDP;ob;expires=1800 Date: Sat, 15 Mar 2014 11:54:22 GMT Content-Length: 0 \<------------\> [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 0 [14]: SIP/2.0 200 OK [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 1 [124]: Via: SIP/2.0/UDP $FIREWALL\_IP:5066;branch=z9hG4bKPjqL34R.IeymP0EoRJLvlkNnuTLB9bGDlz;alias;received=$FIREWALL\_IP;rport=5066 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 2 [66]: From: sip:103@$ASTERISK\_IP;tag=EM.0nmIg6wlwzZHg.Q07UPdq9T82zo5j [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 3 [42]: To: sip:103@$ASTERISK\_IP;tag=as6489bd6a [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 4 [41]: Call-ID: QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 5 [20]: CSeq: 52502 REGISTER [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 6 [27]: Server: Asterisk PBX 11.8.1 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 7 [81]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 8 [26]: Supported: replaces, timer [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 9 [13]: Expires: 1800 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 10 [67]: Contact: sip:103@:5066$FIREWALL\_IP;transport=UDP;ob;expires=1800 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 11 [35]: Date: Sat, 15 Mar 2014 11:54:22 GMT [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 12 [17]: Content-Length: 0 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 13 [0]: [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Trying to put ‘SIP/2.0 200’ onto UDP socket destined for $FIREWALL\_IP:5066 [Mar 15 15:54:22] DEBUG[15094] devicestate.c: No provider found, checking channel drivers for SIP - 103 [Mar 15 15:54:22] DEBUG[15094] chan\_sip.c: Checking device state for peer 103 [Mar 15 15:54:22] DEBUG[15094] devicestate.c: Changing state for SIP/103 - state 1 (Not in use) [Mar 15 15:54:22] DEBUG[15094] devicestate.c: device ‘SIP/103’ state ‘1’ [Mar 15 15:54:22] VERBOSE[15103] chan\_sip.c: Scheduling destruction of SIP dialog ‘QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW’ in 32000 ms (Method: REGISTER) [Mar 15 15:54:22] DEBUG[15128] app\_queue.c: Device ‘SIP/103’ changed to state ‘1’ (Not in use) but we don’t care because they’re not a member of any queue. [Mar 15 15:54:22] VERBOSE[15103] chan\_sip.c: \<— SIP read from UDP:$FIREWALL\_IP:5066 —\> REGISTER sip:$ASTERISK\_IP;transport=udp SIP/2.0 Via: SIP/2.0/UDP $FIREWALL\_IP:5066;rport;branch=z9hG4bKPjDGG8OLYhEZ8Jn4dXj1JIgoXpEHLSz8-y;alias Max-Forwards: 70 From: sip:103@$ASTERISK\_IP;tag=y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg To: sip:103@$ASTERISK\_IP Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 CSeq: 59795 REGISTER User-Agent: Konftel300IP 2.2.9 Contact: sip:103@192.168.1.54:5066;ob Expires: 0 Authorization: Digest username=“103”, realm=“asterisk”, nonce=“42318b42”, uri=“sip:$ASTERISK\_IP;transport=udp”, response=“2378fc64403ae7f6064035531544976e”, algorithm=MD5 Content-Length: 0 \<-------------\> [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 0 [48]: REGISTER sip:$ASTERISK\_IP;transport=udp SIP/2.0 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 1 [96]: Via: SIP/2.0/UDP $FIREWALL\_IP:5066;rport;branch=z9hG4bKPjDGG8OLYhEZ8Jn4dXj1JIgoXpEHLSz8-y;alias [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 2 [16]: Max-Forwards: 70 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 3 [66]: From: sip:103@$ASTERISK\_IP;tag=y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 4 [27]: To: sip:103@$ASTERISK\_IP [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 5 [41]: Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 6 [20]: CSeq: 59795 REGISTER [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 7 [30]: User-Agent: Konftel300IP 2.2.9 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 8 [39]: Contact: sip:103@192.168.1.54:5066;ob [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 9 [10]: Expires: 0 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 10 [171]: Authorization: Digest username=“103”, realm=“asterisk”, nonce=“42318b42”, uri=“sip:$ASTERISK\_IP;transport=udp”, response=“2378fc64403ae7f6064035531544976e”, algorithm=MD5 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 11 [17]: Content-Length: 0 [Mar 15 15:54:22] VERBOSE[15103] chan\_sip.c: — (12 headers 0 lines) — [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: = Looking for Call ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 (Checking From) --From tag y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg --To-tag [Mar 15 15:54:22] DEBUG[15103] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:54:22] DEBUG[15103] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:54:22] DEBUG[15103] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:54:22] DEBUG[15103] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: \*\*\*\* Received REGISTER (2) - Command in SIP REGISTER [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Initializing initreq for method REGISTER - callid PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:22] DEBUG[15103] netsock2.c: Splitting ‘$FIREWALL\_IP:5066’ into… [Mar 15 15:54:22] DEBUG[15103] netsock2.c: …host ‘$FIREWALL\_IP’ and port ‘5066’. [Mar 15 15:54:22] VERBOSE[15103] chan\_sip.c: Sending to $FIREWALL\_IP:5066 (no NAT) [Mar 15 15:54:22] DEBUG[15103] netsock2.c: Splitting ‘$ASTERISK\_IP’ into… [Mar 15 15:54:22] DEBUG[15103] netsock2.c: …host ‘$ASTERISK\_IP’ and port ‘’. [Mar 15 15:54:22] VERBOSE[15103] chan\_sip.c: \<— Transmitting (NAT) to $FIREWALL\_IP:5066 —\> SIP/2.0 200 OK Via: SIP/2.0/UDP $FIREWALL\_IP:5066;branch=z9hG4bKPjDGG8OLYhEZ8Jn4dXj1JIgoXpEHLSz8-y;alias;received=$FIREWALL\_IP;rport=5066 From: sip:103@$ASTERISK\_IP;tag=y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg To: sip:103@$ASTERISK\_IP;tag=as41535b92 Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 CSeq: 59795 REGISTER Server: Asterisk PBX 11.8.1 Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Expires: 0 Date: Sat, 15 Mar 2014 11:54:22 GMT Content-Length: 0 \<------------\> [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 0 [14]: SIP/2.0 200 OK [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 1 [124]: Via: SIP/2.0/UDP $FIREWALL\_IP:5066;branch=z9hG4bKPjDGG8OLYhEZ8Jn4dXj1JIgoXpEHLSz8-y;alias;received=$FIREWALL\_IP;rport=5066 [Mar 15 15:54:22] DEBUG[15094] devicestate.c: No provider found, checking channel drivers for SIP - 103 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 2 [66]: From: sip:103@$ASTERISK\_IP;tag=y6iZu18kb1VvOs4dc4AzAgzyQDA.8sjg [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 3 [42]: To: sip:103@$ASTERISK\_IP;tag=as41535b92 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 4 [41]: Call-ID: PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:22] DEBUG[15094] chan\_sip.c: Checking device state for peer 103 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 5 [20]: CSeq: 59795 REGISTER [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 6 [27]: Server: Asterisk PBX 11.8.1 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 7 [81]: Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 8 [26]: Supported: replaces, timer [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 9 [10]: Expires: 0 [Mar 15 15:54:22] DEBUG[15094] devicestate.c: Changing state for SIP/103 - state 5 (Unavailable) [Mar 15 15:54:22] DEBUG[15094] devicestate.c: device ‘SIP/103’ state ‘5’ [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 10 [35]: Date: Sat, 15 Mar 2014 11:54:22 GMT [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 11 [17]: Content-Length: 0 [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Header 12 [0]: [Mar 15 15:54:22] DEBUG[15103] chan\_sip.c: Trying to put ‘SIP/2.0 200’ onto UDP socket destined for $FIREWALL\_IP:5066 [Mar 15 15:54:22] DEBUG[15128] app\_queue.c: Device ‘SIP/103’ changed to state ‘5’ (Unavailable) but we don’t care because they’re not a member of any queue. [Mar 15 15:54:22] DEBUG[15094] devicestate.c: No provider found, checking channel drivers for SIP - 103 [Mar 15 15:54:22] VERBOSE[15103] chan\_sip.c: Scheduling destruction of SIP dialog ‘PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6’ in 32000 ms (Method: REGISTER) [Mar 15 15:54:22] DEBUG[15094] chan\_sip.c: Checking device state for peer 103 [Mar 15 15:54:22] DEBUG[15094] devicestate.c: Changing state for SIP/103 - state 5 (Unavailable) [Mar 15 15:54:22] DEBUG[15094] devicestate.c: device ‘SIP/103’ state ‘5’ [Mar 15 15:54:22] DEBUG[15128] app\_queue.c: Device ‘SIP/103’ changed to state ‘5’ (Unavailable) but we don’t care because they’re not a member of any queue. [Mar 15 15:54:37] VERBOSE[15103] chan\_sip.c: \<— SIP read from UDP:$FIREWALL\_IP:5066 —\> \<-------------\> [Mar 15 15:54:52] VERBOSE[15103] chan\_sip.c: \<— SIP read from UDP:$FIREWALL\_IP:5066 —\> \<-------------\> [Mar 15 15:54:53] DEBUG[15103] chan\_sip.c: Auto destroying SIP dialog ‘PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6’ [Mar 15 15:54:53] DEBUG[15103] chan\_sip.c: Destroying SIP dialog PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:53] VERBOSE[15103] chan\_sip.c: Really destroying SIP dialog ‘PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6’ Method: REGISTER [Mar 15 15:54:54] DEBUG[15103] chan\_sip.c: Auto destroying SIP dialog ‘QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW’ [Mar 15 15:54:54] DEBUG[15103] chan\_sip.c: Destroying SIP dialog QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW [Mar 15 15:54:54] VERBOSE[15103] chan\_sip.c: Really destroying SIP dialog ‘QzzQJWWZTK5NzB.MDm8MzJzUfM4Ah9UW’ Method: REGISTER [Mar 15 15:54:54] DEBUG[15103] chan\_sip.c: Auto destroying SIP dialog ‘PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6’ [Mar 15 15:54:54] DEBUG[15103] chan\_sip.c: Destroying SIP dialog PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6 [Mar 15 15:54:54] VERBOSE[15103] chan\_sip.c: Really destroying SIP dialog ‘PCUiiBx8ga9Ni6aDgdDW6AgJ4.CwfoY6’ Method: REGISTER [Mar 15 15:55:07] VERBOSE[15103] chan\_sip.c: \<— SIP read from UDP:$FIREWALL\_IP:5066 —\> \<-------------\> [Mar 15 15:55:21] DEBUG[15062] taskprocessor.c: destroying taskprocessor ‘ast\_msg\_queue’ [Mar 15 15:55:21] VERBOSE[15062] asterisk.c: Asterisk cleanly ending (0). [Mar 15 15:55:21] VERBOSE[15062] asterisk.c: Executing last minute cleanups [/code] ---
**Author:** ![david55](https://avatars.discourse-cdn.com/v4/letter/d/e19adc/32.png) [@david55](https://community.asterisk.org/u/david55)\ **Post date:** [March 15, 2014, 1:22pm UTC](https://community.asterisk.org/t/sip-cliend-behind-nat-cant-connect/45558/4 "2014-03-15T13:22:58Z")
Disable the SIP support on the firewall and set it for simple port forwarding.