Solved: Internal Server error - Page 2

mmartin84 · ‎10-24-2011

I am currently in the process of configuring a new uc320 + Mediatrix 4402, I am able to dial to the system and it goes through to the correct hunt group etc... But when I try to make an outbound call I am receiving "Internal Server Error" on the handset... Please see syslog extract bellow:

v=0
o=- 118650 118650 IN IP4 192.168.1.2
s=-
c=IN IP4 192.168.1.2
t=0 0
m=audio 16408 RTP/AVP 8 0 2 9 18 96 97 98 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:2 G726-32/8000
a=rtpmap:9 G722/8000
a=rtpmap:18 G729a/8000
a=rtpmap:96 G726-40/8000
a=rtpmap:97 G726-24/8000
a=rtpmap:98 G726-16/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
a=ptime:30
a=sendrecv

Oct 25 11:55:47 UC320W user.debug voice:

Oct 25 11:55:47 UC320W user.debug voice: [5]<<192.168.1.1:5060(327)

Oct 25 11:55:47 UC320W user.debug voice: SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.1.2:5060;branch=z9hG4bK-6ef2be57
From: Excelsior Gold <sip:0893357770@192.168.1.1>;tag=79f2a6d35d32d988o5;ref=105
To: <sip:0406673789@192.168.1.1>
Call-ID: 3cd9ccef-7eca8a1c@192.168.1.2
CSeq: 101 INVITE
Server: Mediatrix 4402/v2.0.10.185 44XX-MX-D2000-66
Content-Length: 0

Oct 25 11:55:47 UC320W user.debug voice:

Oct 25 11:55:48 UC320W user.debug voice: [5]<<192.168.1.1:5060(357)

Oct 25 11:55:48 UC320W user.debug voice: SIP/2.0 500 Internal Server Error
Via: SIP/2.0/UDP 192.168.1.2:5060;branch=z9hG4bK-6ef2be57
From: Excelsior Gold <sip:0893357770@192.168.1.1>;tag=79f2a6d35d32d988o5;ref=105
To: <sip:0406673789@192.168.1.1>;tag=2199816069
Call-ID: 3cd9ccef-7eca8a1c@192.168.1.2
CSeq: 101 INVITE
Server: Mediatrix 4402/v2.0.10.185 44XX-MX-D2000-66
Content-Length: 0

Oct 25 11:55:48 UC320W user.debug voice:

Oct 25 11:55:48 UC320W user.debug voice: [5]->192.168.1.1:5060(482)

Oct 25 11:55:48 UC320W user.debug voice: ACK sip:0406673789@192.168.1.1 SIP/2.0
Via: SIP/2.0/UDP 192.168.1.2:5060;branch=z9hG4bK-6ef2be57
From: Excelsior Gold <sip:0893357770@192.168.1.1>;tag=79f2a6d35d32d988o5;ref=105
To: <sip:0406673789@192.168.1.1>;tag=2199816069
Call-ID: 3cd9ccef-7eca8a1c@192.168.1.2
CSeq: 101 ACK
Max-Forwards: 70
Contact: Excelsior Gold <sip:0893357770@192.168.1.2:5060;ref=0893357770>
User-Agent: Cisco/UC320W-2.1.1(7)
Allow-Events: talk, hold, conference, x-spa-cti
Content-Length: 0

Oct 25 11:55:48 UC320W user.debug voice:

Oct 25 11:55:48 UC320W user.debug voice: ++++ signaling events: 45 509 2b

Oct 25 11:55:48 UC320W user.debug voice: BCC:Failed

Oct 25 11:55:48 UC320W user.debug voice: Voice CDR written

Oct 25 11:55:48 UC320W user.debug voice: ++++ signaling events: 45 509 2b

Oct 25 11:55:48 UC320W user.debug voice: audio restart

Oct 25 11:55:48 UC320W user.debug voice: DLG Terminated 523064

Oct 25 11:55:48 UC320W user.debug voice: Sess Terminated 424ad708

Oct 25 11:55:48 UC320W user.warn kernel: Closing pcm device
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_REC_STOP
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_PLAY_STOP
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_REC_STOP
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_PLAY_STOP
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_REC_STOP
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_PLAY_STOP
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_REC_STOP
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_PLAY_STOP
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_REC_STOP
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_PLAY_STOP
Oct 25 11:55:48 UC320W user.debug voice: aud restarted(50ms)

Oct 25 11:55:48 UC320W user.warn kernel: PHONE_PLAY_START
Oct 25 11:55:48 UC320W user.warn kernel: CPLD indication triggered - Tx/Rx started ok
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_REC_START
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_PLAY_START
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_REC_START
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_PLAY_START
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_REC_START
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_PLAY_START
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_REC_START
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_PLAY_START
Oct 25 11:55:48 UC320W user.warn kernel: PHONE_REC_START
Oct 25 11:55:48 UC320W user.warn kernel: Opening pcm device
Oct 25 11:55:49 UC320W user.debug voice: SAA_DBG:>>>>CheckAADateTime:0

Oct 25 11:55:49 UC320W user.debug voice: localtime is:2011-10-25, 11:55:50

Oct 25 11:55:49 UC320W user.debug voice: start time is:0-0-0

Oct 25 11:55:49 UC320W user.debug voice: end time is:0-0-0

Oct 25 11:55:49 UC320W user.debug voice: SAA_DBG: AA 1 scipt 0

Oct 25 11:55:55 UC320W user.debug voice: TFTPS:<<b01010a:1033 /cfg/reports/spa504G_30e4db809766.xmls

Oct 25 11:55:55 UC320W user.debug voice: TFTPS: Put </home/usb_disk/cfg/reports/spa504G_30e4db809766.xmls>

Oct 25 11:55:55 UC320W user.debug voice: report profile spa504G_30e4db809766.xmls no change

Oct 25 11:55:55 UC320W user.debug voice: report address book spa504G_30e4db809766.xmls no change

Oct 25 11:56:04 UC320W user.debug voice: SAA_DBG:>>>>CheckAADateTime:0

Oct 25 11:56:04 UC320W user.debug voice: localtime is:2011-10-25, 11:56:4

Oct 25 11:56:04 UC320W user.debug voice: start time is:0-0-0

Oct 25 11:56:04 UC320W user.debug voice: end time is:0-0-0

Oct 25 11:56:04 UC320W user.debug voice: SAA_DBG: AA 1 scipt 0

Oct 25 11:56:11 UC320W user.debug kernel: sysevt_comm_sendto: (60, rc)=>
Oct 25 11:56:17 UC320W user.debug kernel: sysevt_comm_sendto: (60, rc)=>
Oct 25 11:56:17 UC320W user.debug kernel: sysevt_comm_sendto: (60, rc)=>
Oct 25 11:56:19 UC320W user.debug voice: SAA_DBG:>>>>CheckAADateTime:0

Oct 25 11:56:19 UC320W user.debug voice: localtime is:2011-10-25, 11:56:19

Oct 25 11:56:19 UC320W user.debug voice: start time is:0-0-0

Oct 25 11:56:19 UC320W user.debug voice: end time is:0-0-0

Oct 25 11:56:19 UC320W user.debug voice: SAA_DBG: AA 1 scipt 0

Oct 25 11:56:20 UC320W user.debug voice: Sess Terminated 424af978

Oct 25 11:56:21 UC320W user.debug voice: CC:Clean Up

Oct 25 11:56:21 UC320W user.debug voice: --- OBJ POOL STAT ---

Oct 25 11:56:21 UC320W user.debug voice: OP:RTPRXB = 96 ( 96 192)
Oct 25 11:56:21 UC320W user.debug voice: OP:RTPREB = 40 ( 40 48)

Oct 25 11:56:21 UC320W user.debug voice: OP:RTPTXB = 64 ( 64 108)
Oct 25 11:56:21 UC320W user.debug voice: OP:TIMEOU = 95 (152 52)

Oct 25 11:56:21 UC320W user.debug voice: OP:SIPCOR = 0 ( 1 32)
Oct 25 11:56:21 UC320W user.debug voice: OP:SIPCTS = 48 ( 48 624)

Oct 25 11:56:21 UC320W user.debug voice: OP:SIPSTS = 36 ( 64 6076)
Oct 25 11:56:21 UC320W user.debug voice: OP:SIPAUS = 8 ( 8 680)

Oct 25 11:56:21 UC320W user.debug voice: OP:SIPDLG = 58 ( 58 164)
Oct 25 11:56:21 UC320W user.debug voice: OP:SIPSES = 40 ( 40 8816)

Oct 25 11:56:21 UC320W user.debug voice: OP:SIPREG = 20 ( 26 468)
Oct 25 11:56:21 UC320W user.debug voice: OP:SIPLIN = 0 ( 15 148)

Oct 25 11:56:21 UC320W user.debug voice: OP:SUBDLG = 0 ( 19 6740)
Oct 25 11:56:21 UC320W user.debug voice: OP:STUNTS = 32 ( 32 68)

Oct 25 11:56:21 UC320W user.debug voice: OP:SIPCTI = 1 ( 9 7428)
Oct 25 11:56:21 UC320W user.debug voice: OP:XMNODE = 1024 (1024 112)

Oct 25 11:56:21 UC320W user.debug voice:

mmartin84 · ‎10-25-2011

Just completed a log and the high lighted line stood out to me, not sure if it is related?

Christopher Edgeworth · ‎10-25-2011

I see on the previous screen that the max calls is 0? Shouldn't that be 2? The call is failing several rows above your highlighted entry on the next screenshot: FindDestination: Call is not allowed.

Chris

Christopher Edgeworth · ‎10-25-2011

Hi Matthew,

The UC320W and Mediatrix do not register with each other.

Chris

mmartin84 · ‎10-30-2011

Cheers for all the help guys, is working stable now!

support_gimas · ‎11-18-2011

Hello Matthw,

i have the same issue and what is the solution to fix this problem ?

Best Regards

Sascha

mmartin84 · ‎11-20-2011

Hello Sascha,

On the interface configuration page of the Mediatrix box, se the maximum active calls to how ever many lines you have avalible… eg isdn2 – set maximum active calls to 2.

Thanks,

Matthew Martin | Network Support Engineer | Stellar Systems Pty Ltd

Enquiries: +61 8 9349 6222 | Support: +61 8 9349 6444

Direct: +61 8 9264 9007 | Fax: +61 8 9349 7444

Web: www.stellar.com.au<> | Shop: shop.stellar.com.au<>

mmartin84 · ‎01-03-2012

Not sure if I should start a new thread for this, but we are having an issue where all incoming calls via the ISDN lines are showing as "anonymous" on the handsets, I have run syslog on the Mediatrix when completing an incoming call, and the only related messages I can see in the log are;

To: <92707200>;tag=213eba456046a1d3i5 192.168.2.253 03/01 16:45:26.052

<191>syslog: SipSignaling [280F] < From: ;tag=d11d594c22 192.168.2.253 03/01 16:45:26.052

Can some one please advise if this is the ISDN service provider sending through the call as anonymous or if it is a feature on the system that needs to be changed?

Christopher Edgeworth · ‎01-03-2012

Hi Matthew,

Suggest looking at the ISDN logs if you suspect the call may be being sent as anonymous or as a private number.

Chris

focusonit · ‎01-04-2012

Also you must have Point to Multipoint configured by Telstra or it wont work (even though selecting point to point appears to bring up both layers)

Alberto Montilla · ‎01-05-2012

To all, please note we have posted an appendix for covering configuration for Telstra Australia (additional settings)

https://supportforums.cisco.com/docs/DOC-21838

We are also working to include additional countries on this page

https://supportforums.cisco.com/docs/DOC-15130

Regards;
Alberto

focusonit · ‎01-08-2012

Hi,

I think you need to specify that the device only seems to work with Point to Multipoint. - Setting point to point doesn't work if thats what sort of ISDN you have.

Telstra can supply the ISDN either way

mmartin84 · ‎01-08-2012

I have it set as point to point, and all incoming and outgoing calls are working correctly. I believe this to be the correct setup for any phone system using an ISDN line. The only issue I am having is that it is not showing the incoming caller details, I will have another go at running sys logs from the mediatrix box, I am not sure which option to select to obtain ISDN logs...

focusonit · ‎01-08-2012

Ummm I couldn't get it working point to point no matter what I tried!

Our setup is 2x isdn2 with indial point to point

I'm 99% sure that I got caller ID working.

I can check tomorrow and report back if you want. Are you able to send me a screen shot of your isdn settings?

Sent from my iPhone

mmartin84 · ‎01-08-2012

I will login later today and get a screen shot for you, when I was setting up the original site I was unable to get it working with point to multipoint and when I was talking to the Telstra technician he advised me that point to point is the correct configuration for a phone system, so we had this changed at their end and on the mediatrix and all incoming and outgoing calls worked correctly.

focusonit · ‎01-08-2012

I'm sure you have checked this already but is the isdn service subscribed to show/provide caller id? About $6 per month extra

Sent from my iPhone