hi,
I config the 6608 PRI , and it registered in CCM , however I can't make
outgoing call. 7 digit and 10 digit
I capture debug from Tracy Tool.
Can anybody help me understand what is wrong from my debug ?
Thks
Live trace on 177.1.71.20
Log File Opened 10/15/08 07:19:15
07:19:01.900 (GMSG) Statusing TCP Socket for CP#0
07:19:01.950 (MGCP) Outgoing CMD: Adding transID<50> CMD to outgoing list
07:19:01.950 (MGCP) Outgoing CMD: Re-starting list timer
07:19:01.950 (MGCP)Outgoing Msg:
NTFY 50 [EMAIL PROTECTED] MGCP 0.1
X: 0
O:
07:19:02.000 (MGCP) Incoming RSP: Matching transID<50> found on outgoing list,
removing CMD
07:19:02.000 (MGCP)Incoming Msg:
200 50
(NMP) Set Mask -> Mask<0x0>
(DSP) Set Mask -> Mask<0x0>
07:19:14.770 (LINE) TraceMask value = 00000000
Where Bit0 = Call Control Statess
Bit1 = Q931
Bit2 = Q931 Msg's
Bit3 = Line Restarts
Bit4 = E&M Trunk States/Events
Bit5 = Ground Start Trunk States/Events
Bit6 = Loop Start Trunk States/Events
Bit7 = Robbed Bit Signalling Changes
(GMSG) Set Mask -> Mask<0xFF>
(CFG) Set Mask -> Mask<0x0>
(XA) Set Mask -> Mask<0x0>
07:19:14.770 SPAN: --> TraceMask value = 00000000
TraceMask bit 0x01 --> Show Frameslips
TraceMask bit 0x02 --> Show Alarm Changes
TraceMask bit 0x04 --> Show HDLC Rx Errors
TraceMask bit 0x08 --> Show HDLC Tx/Rx Msgs
TraceMask bit 0x10 --> Show FDL Errors
TraceMask bit 0x20 --> Show ANSI PRM Tx/Rx
TraceMask bit 0x40 --> Show FDL BOCs
TraceMask bit 0x80 --> Show FDL TABS Req/Resp
TraceMask bit 0x100 --> Show Raw 1-sec Stats
TraceMask bit 0x200 --> Show Rcv Signalling Changes
07:19:14.770 (Q921) --> TraceMask value = 000000ff
Where Bit0 = BackHaul Status Messages -- DL-Est Req/Cfm, DL-Rel
Req/Cfm, ...
Bit1 = BackHaul Operational Messages -- Data Ind/Req
Bit2 = D-Channel Messages -- SABME, UA, DISC, RR, ...
Bit3 = Timer Events
Bit4 = Error Events
Bit5 = State Machine Events
Bit6 = Show Variables in I-Frame Received
Bit7 = Decoded PRI Q.931 Messages
07:19:16.950 (MGCP) Outgoing CMD: Adding transID<51> CMD to outgoing list
07:19:16.950 (MGCP) Outgoing CMD: Re-starting list timer
07:19:16.950 (MGCP)Outgoing Msg:
NTFY 51 [EMAIL PROTECTED] MGCP 0.1
X: 0
O:
07:19:16.950 (MGCP) Incoming RSP: Matching transID<51> found on outgoing list,
removing CMD
07:19:16.950 (MGCP)Incoming Msg:
200 51
07:19:23.800 Q921: T203 Timeout
07:19:23.800 Q921: T203 Expired
07:19:23.800 Q921sm: From ST_MultipleFrameEstablished, To ST_TimerRecover,
Event EV_T203Expire
07:19:23.800 Q921: Send RR
07:19:23.800 Q921: Start T200
07:19:23.800 Q921: ProcDChan - SAPI = 0x0, TEI = 0x1,RxSeq = 0x19, TxSeq = 0x0,
Event = RR, Length=4
07:19:23.800 Q921: Variables - Vr = 018, Vs = 012, Va = 012, Nr = 012, Ns = 017
07:19:23.800 Q921 -- RCV RR
07:19:23.800 Q921sm: From ST_TimerRecover, To ST_TmrRcovrRRnREJ, Event EV_RR
07:19:23.800 Q921sm: From ST_TmrRcovrRRnREJ, To ST_MultipleFrameEstablished,
Event EV_TmrRcovrRRnREJ_C
07:19:23.800 Q921: Stop T200
07:19:23.800 Q921: Start T203
(NMP) Set Mask -> Mask<0x0>
(DSP) Set Mask -> Mask<0x0>
07:19:26.010 (LINE) TraceMask value = 00000000
Where Bit0 = Call Control Statess
Bit1 = Q931
Bit2 = Q931 Msg's
Bit3 = Line Restarts
Bit4 = E&M Trunk States/Events
Bit5 = Ground Start Trunk States/Events
Bit6 = Loop Start Trunk States/Events
Bit7 = Robbed Bit Signalling Changes
(GMSG) Set Mask -> Mask<0xFF>
(CFG) Set Mask -> Mask<0x0>
(XA) Set Mask -> Mask<0x0>
07:19:26.010 SPAN: --> TraceMask value = 00000000
TraceMask bit 0x01 --> Show Frameslips
TraceMask bit 0x02 --> Show Alarm Changes
TraceMask bit 0x04 --> Show HDLC Rx Errors
TraceMask bit 0x08 --> Show HDLC Tx/Rx Msgs
TraceMask bit 0x10 --> Show FDL Errors
TraceMask bit 0x20 --> Show ANSI PRM Tx/Rx
TraceMask bit 0x40 --> Show FDL BOCs
TraceMask bit 0x80 --> Show FDL TABS Req/Resp
TraceMask bit 0x100 --> Show Raw 1-sec Stats
TraceMask bit 0x200 --> Show Rcv Signalling Changes
07:19:26.020 (Q921) --> TraceMask value = 000000ff
Where Bit0 = BackHaul Status Messages -- DL-Est Req/Cfm, DL-Rel
Req/Cfm, ...
Bit1 = BackHaul Operational Messages -- Data Ind/Req
Bit2 = D-Channel Messages -- SABME, UA, DISC, RR, ...
Bit3 = Timer Events
Bit4 = Error Events
Bit5 = State Machine Events
Bit6 = Show Variables in I-Frame Received
Bit7 = Decoded PRI Q.931 Messages
07:19:29.540 (MGCP)Incoming Msg:
CRCX 268 S0/DS1-0/[EMAIL PROTECTED] MGCP 0.1
C: D00000000100005a000000F500000007
L: p:20, a:PCMU, s:off, t:b8
M: recvonly
07:19:29.550 (MGCP) Incoming CMD: Adding transID<268> CMD to incoming list
07:19:29.550 (MGCP) Outgoing RSP: Matching transID<268> found on incoming list,
removing CMD
07:19:29.550 (MGCP) Outgoing RSP: Adding transID<268> RSP to outgoing list
07:19:29.550 (MGCP) Outgoing RSP: Re-starting list timer
07:19:29.550 (MGCP)Outgoing Msg:
200 268
I: 1
v=0
o=- D00000000100005a000000F500000007 0 IN IP4 177.1.71.20
s=Cisco SDP 0
c=IN IP4 177.1.71.20
t=0 0
m=audio 18608 RTP/AVP 0
07:19:29.550 Q921: Data Request Received -- Len = 45
07:19:29.550 Q931: CCM --> Wan Setup
callref = <0x8007>
channel = <1>
07:19:29.550 Q921sm: From ST_MultipleFrameEstablished, To
ST_MultipleFrameEstablished, Event EV_DataRequest
07:19:29.550 Q921sm: From ST_MultipleFrameEstablished, To
ST_MultipleFrameEstablished, Event EV_IFrameQueUp
07:19:29.550 Q921: Send I-Frame
07:19:29.550 Q921: Stop T203
07:19:29.550 Q921: Start T200
07:19:29.560 Q921: ProcDChan - SAPI = 0x0, TEI = 0x1,RxSeq = 0x1a, TxSeq = 0x0,
Event = RR, Length=4
07:19:29.560 Q921: Variables - Vr = 018, Vs = 013, Va = 012, Nr = 012, Ns = 017
07:19:29.560 Q921 -- RCV RR
07:19:29.560 Q921sm: From ST_MultipleFrameEstablished, To ST_MltplFrmEstblshRR,
Event EV_RR
07:19:29.560 Q921sm: From ST_MltplFrmEstblshRR, To ST_MultipleFrameEstablished,
Event EV_MltplFrmEstblshRR_A
07:19:29.560 Q921: Stop T200
07:19:29.560 Q921: Restart T203
07:19:29.570 Q921: ProcDChan - SAPI = 0x2, TEI = 0x1,RxSeq = 0x1a, TxSeq =
0x12, Event = I-Frame, Length=14
07:19:29.570 Q921: Variables - Vr = 018, Vs = 013, Va = 013, Nr = 013, Ns = 000
07:19:29.570 Q921sm: From ST_MultipleFrameEstablished, To ST_MltplFrmEstblshI,
Event EV_ICmd
07:19:29.570 Q921: Send Q931
07:19:29.570 Q931: Wan --> CCM Call_Proceeding
callref = <0x7>
channel = <1>
07:19:29.580 Q921: Send RR
07:19:29.580 Q921sm: From ST_MltplFrmEstblshI, To ST_MultipleFrameEstablished,
Event EV_MltplFrmEstblshI_A
07:19:29.580 Q921: Stop T200
07:19:29.580 Q921: Restart T203
07:19:29.580 Q921: ProcDChan - SAPI = 0x2, TEI = 0x1,RxSeq = 0x1a, TxSeq =
0x13, Event = I-Frame, Length=13
07:19:29.580 Q921: Variables - Vr = 019, Vs = 013, Va = 013, Nr = 013, Ns = 018
07:19:29.580 Q921sm: From ST_MultipleFrameEstablished, To ST_MltplFrmEstblshI,
Event EV_ICmd
07:19:29.580 Q921: Send Q931
07:19:29.580 Q931: Wan --> CCM Disconnect
callref = <0x7>
cause = <0x81>
07:19:29.580 Q921: Send RR
07:19:29.580 Q921sm: From ST_MltplFrmEstblshI, To ST_MultipleFrameEstablished,
Event EV_MltplFrmEstblshI_A
07:19:29.580 Q921: Stop T200
07:19:29.580 Q921: Restart T203
07:19:29.580 (MGCP)Incoming Msg:
DLCX 269 S0/DS1-0/[EMAIL PROTECTED] MGCP 0.1
C: D00000000100005a000000F500000007
I: 1
X: 1
S:
07:19:31.900 ### Lost 32 Traces ### (GMSG) Statusing TCP Socket for CP#0
07:19:31.950 (MGCP) Outgoing CMD: Adding transID<52> CMD to outgoing list
07:19:31.950 (MGCP)Outgoing Msg:
NTFY 52 [EMAIL PROTECTED] MGCP 0.1
X: 0
O:
07:19:31.950 (MGCP) Incoming RSP: Matching transID<52> found on outgoing list,
removing CMD
07:19:31.950 (MGCP)Incoming Msg:
200 52
07:19:39.600 Q921: T203 Timeout
07:19:39.600 Q921: T203 Expired
07:19:39.600 Q921sm: From ST_MultipleFrameEstablished, To ST_TimerRecover,
Event EV_T203Expire
07:19:39.600 Q921: Send RR
07:19:39.600 Q921: Start T200
07:19:39.600 Q921: ProcDChan - SAPI = 0x0, TEI = 0x1,RxSeq = 0x1d, TxSeq = 0x0,
Event = RR, Length=4
07:19:39.600 Q921: Variables - Vr = 021, Vs = 014, Va = 014, Nr = 014, Ns = 020
07:19:39.600 Q921 -- RCV RR
07:19:39.600 Q921sm: From ST_TimerRecover, To ST_TmrRcovrRRnREJ, Event EV_RR
07:19:39.600 Q921sm: From ST_TmrRcovrRRnREJ, To ST_MultipleFrameEstablished,
Event EV_TmrRcovrRRnREJ_C
07:19:39.600 Q921: Stop T200
07:19:39.600 Q921: Start T203
Live trace on 177.1.71.20
Log File Opened 10/15/08 07:22:49
07:22:41.010 Q921: T203 Timeout
07:22:41.010 Q921: T203 Expired
07:22:41.010 Q921sm: From ST_MultipleFrameEstablished, To ST_TimerRecover,
Event EV_T203Expire
07:22:41.010 Q921: Send RR
07:22:41.010 Q921: Start T200
07:22:41.010 Q921: ProcDChan - SAPI = 0x0, TEI = 0x1,RxSeq = 0x1, TxSeq = 0x0,
Event = RR, Length=4
07:22:41.010 Q921: Variables - Vr = 000, Vs = 000, Va = 000, Nr = 000, Ns = 020
07:22:41.010 Q921 -- RCV RR
07:22:41.010 Q921sm: From ST_TimerRecover, To ST_TmrRcovrRRnREJ, Event EV_RR
07:22:41.010 Q921sm: From ST_TmrRcovrRRnREJ, To ST_MultipleFrameEstablished,
Event EV_TmrRcovrRRnREJ_C
07:22:41.010 Q921: Stop T200
07:22:41.010 Q921: Start T203
07:22:41.760 (MGCP) Outgoing CMD: Adding transID<67> CMD to outgoing list
07:22:41.760 (MGCP) Outgoing CMD: Re-starting list timer
07:22:41.760 (MGCP)Outgoing Msg:
NTFY 67 [EMAIL PROTECTED] MGCP 0.1
X: 0
O:
07:22:41.760 (MGCP) Incoming RSP: Matching transID<67> found on outgoing list,
removing CMD
07:22:41.760 (MGCP)Incoming Msg:
200 67
07:22:51.010 Q921: T203 Timeout
07:22:51.010 Q921: T203 Expired
07:22:51.010 Q921sm: From ST_MultipleFrameEstablished, To ST_TimerRecover,
Event EV_T203Expire
07:22:51.010 Q921: Send RR
07:22:51.010 Q921: Start T200
07:22:51.010 Q921: ProcDChan - SAPI = 0x0, TEI = 0x1,RxSeq = 0x1, TxSeq = 0x0,
Event = RR, Length=4
07:22:51.010 Q921: Variables - Vr = 000, Vs = 000, Va = 000, Nr = 000, Ns = 020
07:22:51.010 Q921 -- RCV RR
07:22:51.010 Q921sm: From ST_TimerRecover, To ST_TmrRcovrRRnREJ, Event EV_RR
07:22:51.010 Q921sm: From ST_TmrRcovrRRnREJ, To ST_MultipleFrameEstablished,
Event EV_TmrRcovrRRnREJ_C
07:22:51.010 Q921: Stop T200
07:22:51.010 Q921: Start T203
07:22:56.700 (GMSG) Statusing TCP Socket for CP#0
07:22:56.760 (MGCP) Outgoing CMD: Adding transID<68> CMD to outgoing list
07:22:56.760 (MGCP) Outgoing CMD: Re-starting list timer
07:22:56.760 (MGCP)Outgoing Msg:
NTFY 68 [EMAIL PROTECTED] MGCP 0.1
X: 0
O:
07:22:56.780 (MGCP) Incoming RSP: Matching transID<68> found on outgoing list,
removing CMD
07:22:56.780 (MGCP)Incoming Msg:
200 68
07:22:57.410 (MGCP)Incoming Msg:
CRCX 293 S0/DS1-0/[EMAIL PROTECTED] MGCP 0.1
C: D000000001000060000000F500000001
M: inactive
07:22:57.410 (MGCP) Incoming CMD: Adding transID<293> CMD to incoming list
07:22:57.410 (MGCP) Outgoing RSP: Matching transID<293> found on incoming list,
removing CMD
07:22:57.410 (MGCP) Outgoing RSP: Adding transID<293> RSP to outgoing list
07:22:57.410 (MGCP) Outgoing RSP: Re-starting list timer
07:22:57.410 (MGCP)Outgoing Msg:
200 293
I: 1
v=0
o=- D000000001000060000000F500000001 0 IN IP4 177.1.71.20
s=Cisco SDP 0
c=IN IP4 177.1.71.20
t=0 0
m=audio 18610 RTP/AVP 0
07:22:57.410 Q921: Data Request Received -- Len = 48
07:22:57.410 Q931: CCM --> Wan Setup
callref = <0x8001>
channel = <1>
07:22:57.410 Q921sm: From ST_MultipleFrameEstablished, To
ST_MultipleFrameEstablished, Event EV_DataRequest
07:22:57.410 Q921sm: From ST_MultipleFrameEstablished, To
ST_MultipleFrameEstablished, Event EV_IFrameQueUp
07:22:57.410 Q921: Send I-Frame
07:22:57.410 Q921: Stop T203
07:22:57.410 Q921: Start T200
07:22:57.420 Q921: ProcDChan - SAPI = 0x0, TEI = 0x1,RxSeq = 0x2, TxSeq = 0x0,
Event = RR, Length=4
07:22:57.420 Q921: Variables - Vr = 000, Vs = 001, Va = 000, Nr = 000, Ns = 020
07:22:57.420 Q921 -- RCV RR
07:22:57.420 Q921sm: From ST_MultipleFrameEstablished, To ST_MltplFrmEstblshRR,
Event EV_RR
07:22:57.420 Q921sm: From ST_MltplFrmEstblshRR, To ST_MultipleFrameEstablished,
Event EV_MltplFrmEstblshRR_A
07:22:57.420 Q921: Stop T200
07:22:57.420 Q921: Restart T203
07:22:57.440 Q921: ProcDChan - SAPI = 0x2, TEI = 0x1,RxSeq = 0x2, TxSeq = 0x0,
Event = I-Frame, Length=14
07:22:57.440 Q921: Variables - Vr = 000, Vs = 001, Va = 001, Nr = 001, Ns = 000
07:22:57.440 Q921sm: From ST_MultipleFrameEstablished, To ST_MltplFrmEstblshI,
Event EV_ICmd
07:22:57.440 Q921: Send Q931
07:22:57.440 Q931: Wan --> CCM Call_Proceeding
callref = <0x1>
channel = <1>
07:22:57.440 Q921: Send RR
07:22:57.440 Q921sm: From ST_MltplFrmEstblshI, To ST_MultipleFrameEstablished,
Event EV_MltplFrmEstblshI_A
07:22:57.440 Q921: Stop T200
07:22:57.440 Q921: Restart T203
07:22:57.440 (MGCP)Incoming Msg:
MDCX 294 S0/DS1-0/[EMAIL PROTECTED] MGCP 0.1
C: D000000001000060000000F500000001
I: 1
X: 1
L: p:20, a:PCMU, s:off, t:b8
M: recvonly
07:22:57.440 Q921: ProcDChan - SAPI = 0x2, TEI = 0x1,RxSeq = 0x2, TxSeq = 0x1,
Event = I-Frame, Length=13
07:22:57.440 Q921: Variables - Vr = 001, Vs = 001, Va = 001, Nr = 001, Ns = 000
07:22:57.440 Q921sm: From ST_MultipleFrameEstablished, To ST_MltplFrmEstblshI,
Event EV_ICmd
07:22:57.440 Q921: Send Q931
07:22:57.450 Q931: Wan --> CCM Disconnect
callref = <0x1>
cause = <0x81>
07:22:57.450 Q921: Send RR
07:22:57.450 Q921sm: From ST_MltplFrmEstblshI, To ST_MultipleFrameEstablished,
Event EV_MltplFrmEstblshI_A
07:22:57.450 Q921: Stop T200
07:22:57.450 Q921: Restart T203
07:23:07.480 ### Lost 46 Traces ### Q921: T203 Timeout
07:23:07.480 Q921: T203 Expired
07:23:07.480 Q921sm: From ST_MultipleFrameEstablished, To ST_TimerRecover,
Event EV_T203Expire
07:23:07.480 Q921: Send RR
07:23:07.480 Q921: Start T200
07:23:07.480 Q921: ProcDChan - SAPI = 0x0, TEI = 0x1,RxSeq = 0x5, TxSeq = 0x0,
Event = RR, Length=4
07:23:07.480 Q921: Variables - Vr = 003, Vs = 002, Va = 002, Nr = 002, Ns = 002
07:23:07.480 Q921 -- RCV RR
07:23:07.480 Q921sm: From ST_TimerRecover, To ST_TmrRcovrRRnREJ, Event EV_RR
07:23:07.480 Q921sm: From ST_TmrRcovrRRnREJ, To ST_MultipleFrameEstablished,
Event EV_TmrRcovrRRnREJ_C
07:23:07.480 Q921: Stop T200
07:23:07.480 Q921: Start T203
07:23:11.760 (MGCP) Outgoing CMD: Adding transID<69> CMD to outgoing list
07:23:11.760 (MGCP)Outgoing Msg:
NTFY 69 [EMAIL PROTECTED] MGCP 0.1
X: 0
O:
07:23:11.760 (MGCP) Incoming RSP: Matching transID<69> found on outgoing list,
removing CMD
07:23:11.760 (MGCP)Incoming Msg:
200 69