Re: [asterisk-users] Registration of Snom 320 phone with Asterisk 1.4.13

<--- SIP read from 192.168.0.4:2048 --->
REGISTER sip:192.168.0.2 SIP/2.0
Via: SIP/2.0/UDP 192.168.0.4;branch=z9hG4bK-1fk1w5i9tp27;rport
From: "Jason White" <sip:5549@192.168.0.2>;tag=rrzoty966y
To: "Jason White" <sip:5549@192.168.0.2>
Call-ID: 3c33894c8198-jfnao0gkzzkv
CSeq: 341 REGISTER
Max-Forwards: 70
Contact: <sip:5549@192.168.0.4:2048;line=dz9s1zzw>;flow-id=1;q=1.0;+sip.instance="<urn:uuid:6467e491-3f54-4b76-8777-359712b5e388>";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO"
User-Agent: snom320/7.1.8
Supported: gruu
Allow-Events: dialog
X-Real-IP: 192.168.0.4
Expires: 3600
Content-Length: 0


<------------->
�--- (14 headers 0 lines) ---
�Using latest REGISTER request as basis request
�Sending to 192.168.0.4 : 2048 (NAT)
� jdc*CLI>
<--- Transmitting (no NAT) to 192.168.0.4:5060 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.0.4;branch=z9hG4bK-1fk1w5i9tp27;received=192.168.0.4;rport=2048
From: "Jason White" <sip:5549@192.168.0.2>;tag=rrzoty966y
To: "Jason White" <sip:5549@192.168.0.2>
Call-ID: 3c33894c8198-jfnao0gkzzkv
CSeq: 341 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Supported: replaces
Contact: <sip:5549@192.168.0.2>
Content-Length: 0


<------------>
�
<--- Transmitting (no NAT) to 192.168.0.4:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.0.4;branch=z9hG4bK-1fk1w5i9tp27;received=192.168.0.4;rport=2048
From: "Jason White" <sip:5549@192.168.0.2>;tag=rrzoty966y
To: "Jason White" <sip:5549@192.168.0.2>;tag=as06798431
Call-ID: 3c33894c8198-jfnao0gkzzkv
CSeq: 341 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Supported: replaces
WWW-Authenticate: Digest algorithm=MD5, realm="192.168.0.2", nonce="0048861c"
Content-Length: 0


<------------>
�Scheduling destruction of SIP dialog '3c33894c8198-jfnao0gkzzkv' in 32000 ms (Method: REGISTER)
� jdc*CLI>
<--- SIP read from 192.168.0.4:2048 --->
REGISTER sip:192.168.0.2 SIP/2.0
Via: SIP/2.0/UDP 192.168.0.4;branch=z9hG4bK-1fk1w5i9tp27;rport
From: "Jason White" <sip:5549@192.168.0.2>;tag=rrzoty966y
To: "Jason White" <sip:5549@192.168.0.2>
Call-ID: 3c33894c8198-jfnao0gkzzkv
CSeq: 341 REGISTER
Max-Forwards: 70
Contact: <sip:5549@192.168.0.4:2048;line=dz9s1zzw>;flow-id=1;q=1.0;+sip.instance="<urn:uuid:6467e491-3f54-4b76-8777-359712b5e388>";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO"
User-Agent: snom320/7.1.8
Supported: gruu
Allow-Events: dialog
X-Real-IP: 192.168.0.4
Expires: 3600
Content-Length: 0


<------------->
�--- (14 headers 0 lines) ---
�Using latest REGISTER request as basis request
�Sending to 192.168.0.4 : 2048 (NAT)
�
<--- Transmitting (no NAT) to 192.168.0.4:5060 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.0.4;branch=z9hG4bK-1fk1w5i9tp27;received=192.168.0.4;rport=2048
From: "Jason White" <sip:5549@192.168.0.2>;tag=rrzoty966y
To: "Jason White" <sip:5549@192.168.0.2>
Call-ID: 3c33894c8198-jfnao0gkzzkv
CSeq: 341 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Supported: replaces
Contact: <sip:5549@192.168.0.2>
Content-Length: 0


<------------>
�
<--- Transmitting (no NAT) to 192.168.0.4:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.0.4;branch=z9hG4bK-1fk1w5i9tp27;received=192.168.0.4;rport=2048
From: "Jason White" <sip:5549@192.168.0.2>;tag=rrzoty966y
To: "Jason White" <sip:5549@192.168.0.2>;tag=as06798431
Call-ID: 3c33894c8198-jfnao0gkzzkv
CSeq: 341 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Supported: replaces
WWW-Authenticate: Digest algorithm=MD5, realm="192.168.0.2", nonce="0048861c"
Content-Length: 0


<------------>
�Scheduling destruction of SIP dialog '3c33894c8198-jfnao0gkzzkv' in 32000 ms (Method: REGISTER)
� jdc*CLI>
<--- SIP read from 192.168.0.4:2048 --->
REGISTER sip:192.168.0.2 SIP/2.0
Via: SIP/2.0/UDP 192.168.0.4;branch=z9hG4bK-1fk1w5i9tp27;rport
From: "Jason White" <sip:5549@192.168.0.2>;tag=rrzoty966y
To: "Jason White" <sip:5549@192.168.0.2>
Call-ID: 3c33894c8198-jfnao0gkzzkv
CSeq: 341 REGISTER
Max-Forwards: 70
Contact: <sip:5549@192.168.0.4:2048;line=dz9s1zzw>;flow-id=1;q=1.0;+sip.instance="<urn:uuid:6467e491-3f54-4b76-8777-359712b5e388>";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO"
User-Agent: snom320/7.1.8
Supported: gruu
Allow-Events: dialog
X-Real-IP: 192.168.0.4
Expires: 3600
Content-Length: 0


<------------->
�--- (14 headers 0 lines) ---
� jdc*CLI> Using latest REGISTER request as basis request
�Sending to 192.168.0.4 : 2048 (NAT)
�
<--- Transmitting (no NAT) to 192.168.0.4:5060 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.0.4;branch=z9hG4bK-1fk1w5i9tp27;received=192.168.0.4;rport=2048
From: "Jason White" <sip:5549@192.168.0.2>;tag=rrzoty966y
To: "Jason White" <sip:5549@192.168.0.2>
Call-ID: 3c33894c8198-jfnao0gkzzkv
CSeq: 341 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Supported: replaces
Contact: <sip:5549@192.168.0.2>
Content-Length: 0


<------------>
� jdc*CLI>
<--- Transmitting (no NAT) to 192.168.0.4:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.0.4;branch=z9hG4bK-1fk1w5i9tp27;received=192.168.0.4;rport=2048
From: "Jason White" <sip:5549@192.168.0.2>;tag=rrzoty966y
To: "Jason White" <sip:5549@192.168.0.2>;tag=as06798431
Call-ID: 3c33894c8198-jfnao0gkzzkv
CSeq: 341 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Supported: replaces
WWW-Authenticate: Digest algorithm=MD5, realm="192.168.0.2", nonce="0048861c"
Content-Length: 0


<------------>
�Scheduling destruction of SIP dialog '3c33894c8198-jfnao0gkzzkv' in 32000 ms (Method: REGISTER)
� jdc*CLI>
<--- SIP read from 192.168.0.4:2048 --->
REGISTER sip:192.168.0.2 SIP/2.0
Via: SIP/2.0/UDP 192.168.0.4;branch=z9hG4bK-1fk1w5i9tp27;rport
From: "Jason White" <sip:5549@192.168.0.2>;tag=rrzoty966y
To: "Jason White" <sip:5549@192.168.0.2>
Call-ID: 3c33894c8198-jfnao0gkzzkv
CSeq: 341 REGISTER
Max-Forwards: 70
Contact: <sip:5549@192.168.0.4:2048;line=dz9s1zzw>;flow-id=1;q=1.0;+sip.instance="<urn:uuid:6467e491-3f54-4b76-8777-359712b5e388>";audio;mobility="fixed";duplex="full";description="snom320";actor="principal";events="dialog";methods="INVITE,ACK,CANCEL,BYE,REFER,OPTIONS,NOTIFY,SUBSCRIBE,PRACK,MESSAGE,INFO"
User-Agent: snom320/7.1.8
Supported: gruu
Allow-Events: dialog
X-Real-IP: 192.168.0.4
Expires: 3600
Content-Length: 0


<------------->
�--- (14 headers 0 lines) ---
�Using latest REGISTER request as basis request
� jdc*CLI> Sending to 192.168.0.4 : 2048 (NAT)
�
<--- Transmitting (no NAT) to 192.168.0.4:5060 --->
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.0.4;branch=z9hG4bK-1fk1w5i9tp27;received=192.168.0.4;rport=2048
From: "Jason White" <sip:5549@192.168.0.2>;tag=rrzoty966y
To: "Jason White" <sip:5549@192.168.0.2>
Call-ID: 3c33894c8198-jfnao0gkzzkv
CSeq: 341 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Supported: replaces
Contact: <sip:5549@192.168.0.2>
Content-Length: 0


<------------>
�
<--- Transmitting (no NAT) to 192.168.0.4:5060 --->
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.0.4;branch=z9hG4bK-1fk1w5i9tp27;received=192.168.0.4;rport=2048
From: "Jason White" <sip:5549@192.168.0.2>;tag=rrzoty966y
To: "Jason White" <sip:5549@192.168.0.2>;tag=as06798431
Call-ID: 3c33894c8198-jfnao0gkzzkv
CSeq: 341 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY
Supported: replaces
WWW-Authenticate: Digest algorithm=MD5, realm="192.168.0.2", nonce="0048861c"
Content-Length: 0


<------------>
�Scheduling destruction of SIP dialog '3c33894c8198-jfnao0gkzzkv' in 32000 ms (Method: REGISTER)
�
Here are more details:

The phone and the Asterisk box are behind the same router (the Asterisk
machine is 192.168.0.2 and the phone is 192.168.0.4).

A ping command works:

jason@jdc:~$ ping -c 10 192.168.0.4
PING 192.168.0.4 (192.168.0.4) 56(84) bytes of data.
64 bytes from 192.168.0.4: icmp_seq=1 ttl=64 time=0.500 ms
64 bytes from 192.168.0.4: icmp_seq=2 ttl=64 time=0.491 ms
64 bytes from 192.168.0.4: icmp_seq=3 ttl=64 time=0.493 ms
64 bytes from 192.168.0.4: icmp_seq=4 ttl=64 time=0.495 ms
64 bytes from 192.168.0.4: icmp_seq=5 ttl=64 time=0.495 ms
64 bytes from 192.168.0.4: icmp_seq=6 ttl=64 time=0.493 ms
64 bytes from 192.168.0.4: icmp_seq=7 ttl=64 time=0.493 ms
64 bytes from 192.168.0.4: icmp_seq=8 ttl=64 time=0.495 ms
64 bytes from 192.168.0.4: icmp_seq=9 ttl=64 time=0.505 ms
64 bytes from 192.168.0.4: icmp_seq=10 ttl=64 time=0.492 ms

--- 192.168.0.4 ping statistics ---
10 packets transmitted, 10 received, 0% packet loss, time 9005ms
rtt min/avg/max/mdev = 0.491/0.495/0.505/0.014 ms
jason@jdc:~$

However, the phone never appears to receive the responses from Asterisk to its
register requests. The error on the phone is:
[2]29/10/2007 17:02:59: Transport Error: Pending packet 1046807: generating
fake
[2]29/10/2007 17:02:59: Registrar 5549@192.168.0.2 timed out

From /etc/asterisk/sip.conf:

[general]
port = 5060 ; Port to bind to
bindaddr = 0.0.0.0 ; Address to bind to A
realm=192.168.0.2
context = default ;Default for incoming calls
[5549]
disallow=all
allow=ulaw
allow=alaw
allow=gsm
type=friend ;(inbound and outbound calls accepted)
secret=localphone ; obvious password for testing
host=dynamic
callerid=Jason White <5549>
dtmfmode=auto
mailbox=5549 ;(Asterisk VM-system's mailbox #)

The output from sip set debug is attached, as captured earlier by the script
command.

Asterisk version 1.4.13, Debian GNU/Linux Sid (up to date); this phone has
successfully registered with external Asterisk servers.

Suggestions are much appreciated.