Zhone MALC Asterisk problem


#1

This is a log from Zhone MALC DSLAM that can act as SIP proxy for POTS subscribers. The main problem is failure in registration proccess.

Can anybody check this log and give me some hints where is the problem?

Thanks in advance

zSH> update voip-server-entry 1/1
Please provide the following: [q]uit.
zhoneVoipServerAddrType: ------> {ipv4}:
zhoneVoipServerAddr: ----------> {192.168.4.100}:
zhoneVoipServerUdpPortNumber: -> {5060}:
zhoneVoipServerId: ------------> {generic}: ?
Invalid entry: zhoneVoipServerId range: longboard asterisk sipexpressrouter metaswitch sylantro broadsoft ubiquity generalbandwidth tekelec-t6000 generic sonus siemens tekelec-t9000 lucent-telica nortel-cs2000 nuera lucent-imerge coppercom newcross cisco
zhoneVoipServerId: ------------> {generic}:
Connection terminated due to inactivity. Please re-login.
login: admin
password:
zSH> update voip-server-entry 1/1
Please provide the following: [q]uit.
zhoneVoipServerAddrType: ------> {ipv4}:
zhoneVoipServerAddr: ----------> {192.168.4.100}:
zhoneVoipServerUdpPortNumber: -> {5060}:
zhoneVoipServerId: ------------> {generic}: asterisk
protocol: ---------------------> {sip}: ** read-only **
sendCallProceedingTone: -------> {false}:
rtcpEnabled: ------------------> {false}:
rtcpPacketInterval: -----------> {5000}:
interdigitTimeOut: ------------> {10}:
ipTos: ------------------------> {0}:
systemDomainName: -------------> {192.168.4.100}:

Save changes? [s]ave, [c]hange or [q]uit:
Save changes? [s]ave, [c]hange or [q]uit:
Save changes? [s]ave, [c]hange or [q]uit:
Save changes? [s]ave, [c]hange or [q]uit: s
APR 04 12:43:49: info : 1/1/49 : sipstack: ***** Tx REGISTER *****
APR 04 12:43:49: info : 1/1/49 : sipstack:
-------------------- 0 --------------------
REGISTER sip:192.168.4.100 SIP/2.0
From: sip:150@192.168.4.100;tag=3562566713
To: sip:150@192.168.4.100
Via: SIP/2.0/UDP 192.168.4.150;branch=z9hG4bK2e268b4e0f794839f2d0d39132227950
Max-Forwards: 70
Expires: 0
Call-ID: c51f4953e1d2a6fa7cc4ed4ceeb1b581@192.168.4.150
CSeq: 1 REGISTER
Contact: sip:150@192.168.4.150:5060
Content-Length: 0

-------------------- 0 --------------------
APR 04 12:43:49: info : 1/1/49 : sipstack: SipStack: Sending message to 192.168.4.100/5060
APR 04 12:43:49: info : 1/1/49 : sipstack: ***** Completed Tx REGISTER *****
APR 04 12:43:49: warning: 1/1/49 : sipstack: Entry already exists in the hash table for the inetAddress [192.168.4.100]
APR 04 12:43:49: info : 1/1/49 : sipstack: ***** Tx REGISTER *****
Record updated.
zSH> APR 04 12:43:49: info : 1/1/49 : sipstack: SipStack: Received message from 192.168.4.100/5060
APR 04 12:43:49: info : 1/1/49 : sipstack: ***** Received INFORMATIONAL RESPONSE (1xx) *****
APR 04 12:43:49: info : 1/1/49 : sipstack:
-------------------- 1 --------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.4.150;branch=z9hG4bK2e268b4e0f794839f2d0d39132227950;received=192.168.4.150
From: sip:150@192.168.4.100;tag=3562566713
To: sip:150@192.168.4.100
Call-ID: c51f4953e1d2a6fa7cc4ed4ceeb1b581@192.168.4.150
CSeq: 1 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY
Contact: sip:150@192.168.4.100
Content-Length: 0

-------------------- 1 --------------------
APR 04 12:43:49: warning: 1/1/49 : sipstack: SIP Session not found for CallId:c51f4953e1d2a6fa7cc4ed4ceeb1b581@192.168.4.150
APR 04 12:43:49: warning: 1/1/49 : sipstack: Failed to find session for SIP 1xx message
APR 04 12:43:53: info : 1/1/49 : sipstack: SipStack: Sending message to 192.168.4.100/5060
APR 04 12:43:53: info : 1/1/49 : sipstack: SipStack: Received message from 192.168.4.100/5060
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Received INFORMATIONAL RESPONSE (1xx) *****
APR 04 12:43:53: info : 1/1/49 : sipstack:
-------------------- 1 --------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.4.150;branch=z9hG4bK2e268b4e0f794839f2d0d39132227950;received=192.168.4.150
From: sip:150@192.168.4.100;tag=3562566713
To: sip:150@192.168.4.100
Call-ID: c51f4953e1d2a6fa7cc4ed4ceeb1b581@192.168.4.150
CSeq: 1 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY
Contact: sip:150@192.168.4.100
Content-Length: 0

-------------------- 1 --------------------
APR 04 12:43:53: warning: 1/1/49 : sipstack: SIP Session not found for CallId:c51f4953e1d2a6fa7cc4ed4ceeb1b581@192.168.4.150
APR 04 12:43:53: warning: 1/1/49 : sipstack: Failed to find session for SIP 1xx message
APR 04 12:43:53: info : 1/1/49 : sipstack: SipStack: Received message from 192.168.4.100/5060
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Received RESPONSE (200 and above) *****
APR 04 12:43:53: info : 1/1/49 : sipstack:
-------------------- 1 --------------------
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.4.150;branch=z9hG4bK2e268b4e0f794839f2d0d39132227950;received=192.168.4.150
From: sip:150@192.168.4.100;tag=3562566713
To: sip:150@192.168.4.100;tag=as713a2426
Call-ID: c51f4953e1d2a6fa7cc4ed4ceeb1b581@192.168.4.150
CSeq: 1 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY
Contact: sip:150@192.168.4.100
WWW-Authenticate: Digest realm=“asterisk”,nonce="62e3f207"
Content-Length: 0

-------------------- 1 --------------------
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Tx REGISTER *****
APR 04 12:43:53: info : 1/1/49 : sipstack: pszUser:150 pszRealm:asterisk pszPass:aabbcc method:REGISTER pszURI:sip:192.168.4.150 pszNonce:62e3f207 pszQop:(null) szNonceCount:00000001 pszCNonce:234abcc436e2667097e7fe6eia53e8dd
APR 04 12:43:53: info : 1/1/49 : sipstack:
-------------------- 0 --------------------
REGISTER sip:192.168.4.100 SIP/2.0
From: sip:150@192.168.4.100;tag=3300490346
To: sip:150@192.168.4.100
Via: SIP/2.0/UDP 192.168.4.150;branch=z9hG4bK4640e199aab377410dcf7b981bcaf6e5
Max-Forwards: 70
Expires: 0
Call-ID: c51f4953e1d2a6fa7cc4ed4ceeb1b581@192.168.4.150
CSeq: 2 REGISTER
Contact: sip:150@192.168.4.150:5060
Authorization: Digest username=“150”,realm=“asterisk”,nonce=“62e3f207”,response=“f72a1da8748730f318179314f6d7a805”,uri=“sip:192.168.4.150”,nc=00000001,cnonce="234abcc436e2667097e7fe6eia53e8dd"
Content-Length: 0

-------------------- 0 --------------------
APR 04 12:43:53: info : 1/1/49 : sipstack: SipStack: Sending message to 192.168.4.100/5060
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Completed Tx REGISTER *****
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Completed RESPONSE (200 and above) *****
APR 04 12:43:53: info : 1/1/49 : sipstack: SipStack: Received message from 192.168.4.100/5060
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Received INFORMATIONAL RESPONSE (1xx) *****
APR 04 12:43:53: info : 1/1/49 : sipstack:
-------------------- 1 --------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.4.150;branch=z9hG4bK4640e199aab377410dcf7b981bcaf6e5;received=192.168.4.150
From: sip:150@192.168.4.100;tag=3300490346
To: sip:150@192.168.4.100
Call-ID: c51f4953e1d2a6fa7cc4ed4ceeb1b581@192.168.4.150
CSeq: 2 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY
Contact: sip:150@192.168.4.100
Content-Length: 0

-------------------- 1 --------------------
APR 04 12:43:53: warning: 1/1/49 : sipstack: SIP Session not found for CallId:c51f4953e1d2a6fa7cc4ed4ceeb1b581@192.168.4.150
APR 04 12:43:53: warning: 1/1/49 : sipstack: Failed to find session for SIP 1xx message
APR 04 12:43:53: info : 1/1/49 : sipstack: SipStack: Received message from 192.168.4.100/5060
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Received RESPONSE (200 and above) *****
APR 04 12:43:53: info : 1/1/49 : sipstack:
-------------------- 1 --------------------
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.4.150;branch=z9hG4bK4640e199aab377410dcf7b981bcaf6e5;received=192.168.4.150
From: sip:150@192.168.4.100;tag=3300490346
To: sip:150@192.168.4.100;tag=as713a2426
Call-ID: c51f4953e1d2a6fa7cc4ed4ceeb1b581@192.168.4.150
CSeq: 2 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY
Contact: sip:150@192.168.4.100
WWW-Authenticate: Digest realm=“asterisk”,nonce="1fa97fc7"
Content-Length: 0

-------------------- 1 --------------------
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Tx REGISTER *****
APR 04 12:43:53: info : 1/1/49 : sipstack:
-------------------- 0 --------------------
REGISTER sip:192.168.4.100 SIP/2.0
From: sip:150@192.168.4.100;tag=3043727692
To: sip:150@192.168.4.100
Via: SIP/2.0/UDP 192.168.4.150;branch=z9hG4bKc29ea9ff0d354af65b60eceef8b5b7e7
Max-Forwards: 70
Expires: 3600
Call-ID: acd800f46876ba507cf6ed88c57a6551@192.168.4.150
CSeq: 1 REGISTER
Contact: sip:150@192.168.4.150:5060
Content-Length: 0

-------------------- 0 --------------------
APR 04 12:43:53: info : 1/1/49 : sipstack: SipStack: Sending message to 192.168.4.100/5060
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Completed Tx REGISTER *****
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Completed RESPONSE (200 and above) *****
APR 04 12:43:53: info : 1/1/49 : sipstack: SipStack: Received message from 192.168.4.100/5060
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Received INFORMATIONAL RESPONSE (1xx) *****
APR 04 12:43:53: info : 1/1/49 : sipstack:
-------------------- 1 --------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.4.150;branch=z9hG4bKc29ea9ff0d354af65b60eceef8b5b7e7;received=192.168.4.150
From: sip:150@192.168.4.100;tag=3043727692
To: sip:150@192.168.4.100
Call-ID: acd800f46876ba507cf6ed88c57a6551@192.168.4.150
CSeq: 1 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY
Contact: sip:150@192.168.4.100
Content-Length: 0

-------------------- 1 --------------------
APR 04 12:43:53: warning: 1/1/49 : sipstack: SIP Session not found for CallId:acd800f46876ba507cf6ed88c57a6551@192.168.4.150
APR 04 12:43:53: warning: 1/1/49 : sipstack: Failed to find session for SIP 1xx message
APR 04 12:43:53: info : 1/1/49 : sipstack: SipStack: Received message from 192.168.4.100/5060
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Received RESPONSE (200 and above) *****
APR 04 12:43:53: info : 1/1/49 : sipstack:
-------------------- 1 --------------------
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.4.150;branch=z9hG4bKc29ea9ff0d354af65b60eceef8b5b7e7;received=192.168.4.150
From: sip:150@192.168.4.100;tag=3043727692
To: sip:150@192.168.4.100;tag=as23e30106
Call-ID: acd800f46876ba507cf6ed88c57a6551@192.168.4.150
CSeq: 1 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY
Contact: sip:150@192.168.4.100
WWW-Authenticate: Digest realm=“asterisk”,nonce="75eac1dc"
Content-Length: 0

-------------------- 1 --------------------
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Tx REGISTER *****
APR 04 12:43:53: info : 1/1/49 : sipstack: pszUser:150 pszRealm:asterisk pszPass:aabbcc method:REGISTER pszURI:sip:192.168.4.150 pszNonce:75eac1dc pszQop:(null) szNonceCount:00000001 pszCNonce:234abcc436e2667097e7fe6eia53e8dd
APR 04 12:43:53: info : 1/1/49 : sipstack:
-------------------- 0 --------------------
REGISTER sip:192.168.4.100 SIP/2.0
From: sip:150@192.168.4.100;tag=1029779304
To: sip:150@192.168.4.100
Via: SIP/2.0/UDP 192.168.4.150;branch=z9hG4bK540bdd88c496df198fc9c36c3e39de19
Max-Forwards: 70
Expires: 3600
Call-ID: acd800f46876ba507cf6ed88c57a6551@192.168.4.150
CSeq: 2 REGISTER
Contact: sip:150@192.168.4.150:5060
Authorization: Digest username=“150”,realm=“asterisk”,nonce=“75eac1dc”,response=“8162ebe51479d96d57e52ecd27d423b7”,uri=“sip:192.168.4.150”,nc=00000001,cnonce="234abcc436e2667097e7fe6eia53e8dd"
Content-Length: 0

-------------------- 0 --------------------
APR 04 12:43:53: info : 1/1/49 : sipstack: SipStack: Sending message to 192.168.4.100/5060
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Completed Tx REGISTER *****
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Completed RESPONSE (200 and above) *****
APR 04 12:43:53: info : 1/1/49 : sipstack: SipStack: Received message from 192.168.4.100/5060
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Received INFORMATIONAL RESPONSE (1xx) *****
APR 04 12:43:53: info : 1/1/49 : sipstack:
-------------------- 1 --------------------
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.4.150;branch=z9hG4bK540bdd88c496df198fc9c36c3e39de19;received=192.168.4.150
From: sip:150@192.168.4.100;tag=1029779304
To: sip:150@192.168.4.100
Call-ID: acd800f46876ba507cf6ed88c57a6551@192.168.4.150
CSeq: 2 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY
Contact: sip:150@192.168.4.100
Content-Length: 0

-------------------- 1 --------------------
APR 04 12:43:53: warning: 1/1/49 : sipstack: SIP Session not found for CallId:acd800f46876ba507cf6ed88c57a6551@192.168.4.150
APR 04 12:43:53: warning: 1/1/49 : sipstack: Failed to find session for SIP 1xx message
APR 04 12:43:53: info : 1/1/49 : sipstack: SipStack: Received message from 192.168.4.100/5060
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Received RESPONSE (200 and above) *****
APR 04 12:43:53: info : 1/1/49 : sipstack:
-------------------- 1 --------------------
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.4.150;branch=z9hG4bK540bdd88c496df198fc9c36c3e39de19;received=192.168.4.150
From: sip:150@192.168.4.100;tag=1029779304
To: sip:150@192.168.4.100;tag=as23e30106
Call-ID: acd800f46876ba507cf6ed88c57a6551@192.168.4.150
CSeq: 2 REGISTER
User-Agent: Asterisk PBX
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,SUBSCRIBE,NOTIFY
Contact: sip:150@192.168.4.100
WWW-Authenticate: Digest realm=“asterisk”,nonce="08343691"
Content-Length: 0

-------------------- 1 --------------------
APR 04 12:43:53: info : 1/1/49 : sipstack: ***** Completed RESPONSE (200 and above) *****
APR 04 12:44:03: error : 1/1/8 : logserver: 1 log messages not written to log due to temporary congestion
APR 04 12:44:06: error : 1/1/8 : logserver: 7 log messages not written to log due to temporary congestion

zSH> sipstack reg

There are 0 SIP Registrations

zSH>