AVAYA SMALL OFFICE EDITION SIP PROBLEM version 4.2.23
Sip line does not work.
This is my Short code
6N
dial
6N
SIP
this is my ARS
6N;
dial
6N "@ 213,162,201,146"
Sip valid license.
I have set ip route 0.0.0.0 0.0.0.0 192.168.42.2 (this is my gateway)
in network lan 1 topology
Firewall type -> unknown
Ip public -> 88.12.183.211 -> My ip is not static
Public port ->
Online sip -> network setup
Layer 4 protocol -> UDP
use network topology info -> none
please help. I'm desperate. thanks
********** System (192.168.42.91) has been up and running for 14secs(14346mS) **********
********** Warning: TEXT File Logging selected **********
********** Warning: TEXT Logging to File STOPPED on 16/12/2009 12:21:06 **********
14347mS PRN: Monitor Started IP=192.168.42.52 IP 401 NG 4.2(23) 00E00701E73D
(IP Office: Supports Unicode, System Locale is esp)
14348mS PRN: LAW=A PRI=0, BRI=4, ALOG=4, ADSL=0 VCOMP=16, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=0 VMAIL=0(VER=0 TYP=1) CALLS=1(TOT=3)
14603mS RES: Wed 16/12/2009 12:21:06 FreeMem=2900712(2) CMMsg=2 (3) Buff=100 499 500 604 5 Links=587
14604mS RES2: RTEngine=0, CMRTEngine=0, Timer=49, Poll=0, Ready=0, CMReady=0, CMQueue=0, VPNNQueue=0
14671mS CMExtnRx: v=299, p1=0
CMReleaseComp
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
14672mS CMCallEvt: 0.1008.0 3 Inalambrico.0: StateChange: END=A CMCSDialling->CMCSCompleted
14674mS CMExtnEvt: v=1 State, new=PortRecoverDelay old=Dialling,0,0,Inalambrico
14681mS CMLOGGING: CALL:2009/12/1613:05,00:00:00,000,299,O,,,Inalambrico,,,1,,""n/a,0
14683mS CD: CALL: 0.1008.0 BState=Idle Cut=0 Music=0.0 Aend="Inalambrico(299)" (0.9) Bend="" [] (0.0) CalledNum= () CallingNum=299 (Inalambrico) Internal=1 Time=392 AState=Idle
14683mS CD: CALL: 0.1008.0 Deleted
14684mS CMExtnEvt: Inalambrico: CALL LOST (CMCauseNormal)
14685mS CMExtnEvt: Inalambrico: Extn(299) Calling Party Number(299) Type(CMNTypeInternal)
14685mS CMExtnEvt: Inalambrico: CMExtnHandler::SetCurrent( id: 1008->0 )
14686mS CMCallEvt: 0.1008.0 -1 Inalambrico.-1: StateChange: END=X CMCSCompleted->CMCSDelete
14688mS CMCallEvt: 0.1009.0 -1 BaseEP: DELETE CMEndpoint ffcfbdec TOTAL NOW=3 CALL_LIST=0
14688mS CMCallEvt: END CALL:3 (ffcfcdfc)
14693mS CMTARGET: 0.1008.0 -1 BaseEP: ~CMTargetHandler
14694mS CMCallEvt: 0.1008.0 -1 BaseEP: DELETE CMEndpoint ffcfd26c TOTAL NOW=2 CALL_LIST=0
14699mS CMMap: a=0.9 b=0.0 D0
14921mS CMCallEvt: 0.1010.0 -1 BaseEP: NEW CMEndpoint ffcfd26c TOTAL NOW=3 CALL_LIST=0
14922mS CMCallEvt: CREATE CALL:4 (ffcfcdfc)
14923mS CMCallEvt: 0.1011.0 -1 BaseEP: NEW CMEndpoint ffcfbdec TOTAL NOW=4 CALL_LIST=0
14937mS CMExtnEvt: Inalambrico: CMExtnHandler::SetCurrent( id: 0->1010 )
14938mS CMExtnEvt: v=1 State, new=Idle old=PortRecoverDelay,0,0,Inalambrico
14939mS CMExtnRx: v=299, p1=0
CMSetup
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[299] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
14940mS CMCallEvt: 0.1010.0 4 Inalambrico.0: StateChange: END=A CMCSIdle->CMCSDialInitiated
14941mS CMExtnEvt: v=1 State, new=Connected old=Idle,0,0,Inalambrico
14943mS CMTARGET: 0.1010.0 4 Inalambrico.0: LOOKUP CALL ROUTE: type=100 called_party= sub= calling=299 dir=out complete=0 ses=0
14944mS CMTARGET: 0.1010.0 4 Inalambrico.0: ADD TARGET (N): number= type=100 depth=1 nobar=1 setorig=1 ses=0
14947mS CMCallEvt: 0.1010.0 4 Inalambrico.0: StateChange: END=A CMCSDialInitiated->CMCSDialling
14948mS CMExtnEvt: v=1 State, new=Dialling old=Connected,0,0,Inalambrico
14949mS CMExtnTx: v=299, p1=0
CMSetupAck
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
BChan: slot=0 chan=9
UUI type=Local [......2Pd.] [0x01 0xff 0x00 0x00 0x01 0x02 0x32 0x50 0x64 0x00 ]
Timed: 16/12/09 12:21
14951mS CD: CALL: 0.1010.0 BState=Idle Cut=1 Music=3.0 Aend="Inalambrico(299)" (0.9) Bend="" [] (0.0) CalledNum= () CallingNum=299 (Inalambrico) Internal=1 Time=28 AState=DialInitiated
14959mS CMMap: a=0.9 b=0.0 D1
15117mS PRN: Sorting User List...
15118mS PRN: User List Sorted
15122mS PRN: Sorting Hunt Group List...
15123mS PRN: Local Hunt Group List Sorted
15127mS PRN: Sorting Directory List...
15128mS PRN: Sorted Directory List.
15130mS PRN: Created Tone MOH Source 1
15132mS PRN: Playing tone MOH Source 1
15135mS PRN: Config Write Completed
15200mS Sip: 0.1005.0 -1 SIPTrunk Endpoint(ffe24da4) EPTerminationTimeout, about to delete endpoint
15200mS Sip: 0.1005.0 -1 SIPTrunk Endpoint(ffe24da4) SIPDialog destructor ... ffe24da4
15201mS CMCallEvt: 0.1005.0 -1 SIPTrunk Endpoint: StateChange: END=X CMCSIdle->CMCSDelete
15201mS Sip: ~SipTrunkEndpoint 0.1005.0 -1 SIPTrunk Endpoint
15203mS CMCallEvt: 0.1005.0 -1 BaseEP: DELETE CMEndpoint ffe25b20 TOTAL NOW=3 CALL_LIST=1
16192mS SIP Tx: UDP 192.168.42.91:5070 -> 213.162.201.146:5060
REGISTER sip:register.awavoz.com SIP/2.0
Via: SIP/2.0/UDP 192.168.42.91:5070;rport;branch=z9hG4bKc9550e36631e9542d880402070592b65
From: sip:3300138@register.awavoz.com;tag=2c0ef06014b47afe
To: sip:3300138@register.awavoz.com
Call-ID: c7ce97e69f55ed353a4b3f54b0808e85@192.168.42.91
CSeq: 1433172533 REGISTER
Contact: "Unknown" <sip:3300138@192.168.42.91:5070;transport=udp>
Expires: 60
Max-Forwards: 70
User-Agent: IP Office 4.2 (23)
Content-Length: 0
16208mS ISDNL1Evt: v=6 peb=6,PHDI
16208mS ISDNL3Evt: v=6 p1=6,p2=1001,p3=4,p4=127,s1=
16209mS ISDNL1Evt: v=7 peb=7,PHDI
16209mS ISDNL3Evt: v=7 p1=7,p2=1001,p3=4,p4=127,s1=
16210mS ISDNL1Evt: v=8 peb=8,PHDI
16210mS ISDNL3Evt: v=8 p1=8,p2=1001,p3=4,p4=127,s1=
16213mS CMLineRx: v=6
CMLineDown
Line: type=Q931Line 6 Call: lid=0 id=-1 in=0
16213mS CMLineTx: v=6
CMRestart
Line: type=Q931Line 6 Call: lid=0 id=-1 in=0
16218mS CMTARGET: CMQ931Trunk:
reprocessInboundMsg - failure_timer set
16219mS CMLineRx: v=7
CMLineDown
Line: type=Q931Line 7 Call: lid=0 id=-1 in=0
16219mS CMLineTx: v=7
CMRestart
Line: type=Q931Line 7 Call: lid=0 id=-1 in=0
16223mS CMTARGET: CMQ931Trunk:reprocessInboundMsg - failure_timer set
16225mS CMLineRx: v=8
CMLineDown
Line: type=Q931Line 8 Call: lid=0 id=-1 in=0
16225mS CMLineTx: v=8
CMRestart
Line: type=Q931Line 8 Call: lid=0 id=-1 in=0
16228mS PRN: ObjectMemoryPool: SSIComponentId, filled 4 times
16230mS CMTARGET: CMQ931Trunk:reprocessInboundMsg - failure_timer set
16232mS ISDNL1Evt: v=5 peb=5,PHDI
16232mS ISDNL3Evt: v=5 p1=5,p2=1001,p3=4,p4=127,s1=
16235mS CMLineRx: v=5
CMLineDown
Line: type=Q931Line 5 Call: lid=0 id=-1 in=0
16236mS CMLineTx: v=5
CMRestart
Line: type=Q931Line 5 Call: lid=0 id=-1 in=0
16240mS CMTARGET: CMQ931Trunk:reprocessInboundMsg - failure_timer set
16245mS ISDNL1Evt: v=8 peb=8,F4 F3
16245mS ISDNL1Evt: v=6 peb=6,F4 F3
16246mS ISDNL1Evt: v=7 peb=7,F4 F3
16337mS ISDNL1Evt: v=5 peb=5,F4 F3
16475mS ISDNL1Evt: v=5 peb=5,F5 F4
16477mS ISDNL1Evt: v=5 peb=5,F6 F5
16493mS ISDNL1Evt: v=5 peb=5,F7 F6
16493mS ISDNL1Evt: v=5 peb=5,PHAI
16514mS ISDNL3Evt: v=5 p1=5,p2=1000,p3=0,p4=0,s1=
16515mS CMLineRx: v=5
CMLineUp
Line: type=Q931Line 5 Call: lid=0 id=-1 in=0
16541mS CMLineRx: v=5
CMRestartAck
Line: type=Q931Line 5 Call: lid=0 id=-1 in=0
16795mS CMExtnEvt: Jose Manuel: ExtnFault now 0
16802mS CMExtnTx: v=203, p1=0
CMVoiceMailStatus
Line: type=DigitalExtn 3 Call: lid=0 id=-1 in=0
Called[Jose Manuel Msgs=0 Old=0 Sav=0] Type=Default (100) Reason=CMDRdirect Calling[00000000] Type=Default Plan=Default
Display [Jose Manuel Msgs=0]
Timed: 16/12/09 12:21
16892mS CMExtnEvt: Principal: ExtnFault now 0
16900mS CMExtnTx: v=201, p1=0
CMVoiceMailStatus
Line: type=DigitalExtn 3 Call: lid=0 id=-1 in=0
Called[Principal Msgs=0 Old=0 Sav=0] Type=Default (100) Reason=CMDRdirect Calling[00000000] Type=Default Plan=Default
Display [Principal Msgs=0]
Timed: 16/12/09 12:21
18800mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[6] Type=Default (100) Reason=CMDRdirect
18803mS CMMap: a=0.9 b=0.0 D0
19275mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[2] Type=Default (100) Reason=CMDRdirect
19632mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[5] Type=Default (100) Reason=CMDRdirect
20013mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[0] Type=Default (100) Reason=CMDRdirect
20193mS SIP Tx: UDP 192.168.42.91:5070 -> 213.162.201.146:5060
REGISTER sip:register.awavoz.com SIP/2.0
Via: SIP/2.0/UDP 192.168.42.91:5070;rport;branch=z9hG4bKc9550e36631e9542d880402070592b65
From: sip:3300138@register.awavoz.com;tag=2c0ef06014b47afe
To: sip:3300138@register.awavoz.com
Call-ID: c7ce97e69f55ed353a4b3f54b0808e85@192.168.42.91
CSeq: 1433172533 REGISTER
Contact: "Unknown" <sip:3300138@192.168.42.91:5070;transport=udp>
Expires: 60
Max-Forwards: 70
User-Agent: IP Office 4.2 (23)
Content-Length: 0
20534mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[6] Type=Default (100) Reason=CMDRdirect
21014mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[4] Type=Default (100) Reason=CMDRdirect
21414mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[8] Type=Default (100) Reason=CMDRdirect
21840mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[1] Type=Default (100) Reason=CMDRdirect
22222mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[1] Type=Default (100) Reason=CMDRdirect
********** SysMonitor v7.0 (8) [connected to 192.168.42.91 (00E00701E73D)] **********
24316mS PRN: Monitor Status IP 401 NG 4.2(23)
24317mS PRN: LAW=A PRI=0, BRI=4, ALOG=4, ADSL=0 VCOMP=16, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=0 VMAIL=0(VER=0 TYP=1) CALLS=1(TOT=4)
24605mS RES: Wed 16/12/2009 12:21:16 FreeMem=2860732(2) CMMsg=2 (3) Buff=100 489 500 608 5 Links=143
24605mS RES2: RTEngine=0, CMRTEngine=0, Timer=47, Poll=0, Ready=0, CMReady=0, CMQueue=0, VPNNQueue=0
26224mS CMTARGET: 0.1010.0 4 Inalambrico.0: TimerExpired cause=CMTCDelayedProcessing
26225mS CMTARGET: 0.1010.0 4 Inalambrico.0: LOOKUP CALL ROUTE: type=100 called_party=625064811 sub= calling=299 dir=out complete=0 ses=0
26226mS CMTARGET: 0.1010.0 4 Inalambrico.0: ADD TARGET (N): number=625064811 type=100 depth=1 nobar=1 setorig=1 ses=0
26226mS CMTARGET: 0.1010.0 4 Inalambrico.0: USER SC: 625064811 2 25064811 sc=type=Dial code=6N, num=6N
26227mS CMARS: FindActiveARSByGroupID GroupID=51 - Found
26228mS CMARS: MakeCallTarget - Called Number: 625064811
26229mS CMCallEvt: 0.1012.0 -1 BaseEP: NEW CMEndpoint ffcd3824 TOTAL NOW=4 CALL_LIST=1
26229mS CMTARGET: 0.1010.0 4 Inalambrico.0: CancelTimer CMTCDialToneTimeout
26230mS CMTARGET: 0.1010.0 4 Inalambrico.0: INITIAL TARGETING SUCCEEDED
26230mS CMTARGET: 0.1010.0 4 Inalambrico.0: GetNoAnswerTimer:99
26232mS CMCallEvt: 0.1011.0 4 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
26233mS CMCallEvt: 0.1012.0 4 ARS for awavoz: StateChange: END=T CMCSIdle->CMCSOffering
26234mS CMCallEvt: 0.1011.0 4 TargetingEP: RequestEnd 0.1012.0 4 ARS for awavoz
26234mS CMTARGET: 0.1010.0 4 Inalambrico.0: CancelTimer CMTCNoAnswerTimeout
26235mS CMCallEvt: 0.1012.0 4 ARS for awavoz: StateChange: END=B CMCSOffering->CMCSOverlapRecv
26236mS CMARS: FORM: awavoz - Received Number: 625064811
26236mS CMARS: CMARSTargetingPending
26237mS CMCallEvt: 0.1011.0 -1 TargetingEP: StateChange: END=X CMCSOffering->CMCSDelete
26237mS CMCallEvt: 0.1011.0 -1 BaseEP: DELETE CMEndpoint ffcfbdec TOTAL NOW=3 CALL_LIST=1
26238mS CD: CALL: 0.1010.0 BState=Idle Cut=2 Music=0.0 Aend="Inalambrico(299)" (0.9) Bend="" [] (0.0) CalledNum=625064811 () CallingNum=299 (Inalambrico) Internal=1 Time=11316 AState=Dialling
26253mS ISDNL1Evt: v=8 peb=8,T3TO
26253mS ISDNL1Evt: v=8 peb=8,F3 F4
26253mS ISDNL1Evt: v=8 peb=8,PHDI
26253mS ISDNL3Evt: v=8 p1=8,p2=1001,p3=4,p4=127,s1=
26254mS ISDNL1Evt: v=6 peb=6,T3TO
26254mS ISDNL1Evt: v=6 peb=6,F3 F4
26254mS ISDNL1Evt: v=6 peb=6,PHDI
26255mS ISDNL3Evt: v=6 p1=6,p2=1001,p3=4,p4=127,s1=
26255mS ISDNL1Evt: v=7 peb=7,T3TO
26255mS ISDNL1Evt: v=7 peb=7,F3 F4
26256mS ISDNL1Evt: v=7 peb=7,PHDI
26256mS ISDNL3Evt: v=7 p1=7,p2=1001,p3=4,p4=127,s1=
26257mS CMLineRx: v=8
CMLineDown
Line: type=Q931Line 8 Call: lid=0 id=-1 in=0
26258mS CMTARGET: CMQ931Trunk:reprocessInboundMsg - failure_timer set
26259mS CMLineRx: v=6
CMLineDown
Line: type=Q931Line 6 Call: lid=0 id=-1 in=0
26259mS CMTARGET: CMQ931Trunk:reprocessInboundMsg - failure_timer set
26260mS CMLineRx: v=7
CMLineDown
Line: type=Q931Line 7 Call: lid=0 id=-1 in=0
26260mS CMTARGET: CMQ931Trunk:reprocessInboundMsg - failure_timer set
26477mS ISDNL1Evt: v=5 peb=5,Locked
28196mS SIP Tx: UDP 192.168.42.91:5070 -> 213.162.201.146:5060
REGISTER sip:register.awavoz.com SIP/2.0
Via: SIP/2.0/UDP 192.168.42.91:5070;rport;branch=z9hG4bKc9550e36631e9542d880402070592b65
From: sip:3300138@register.awavoz.com;tag=2c0ef06014b47afe
To: sip:3300138@register.awavoz.com
Call-ID: c7ce97e69f55ed353a4b3f54b0808e85@192.168.42.91
CSeq: 1433172533 REGISTER
Contact: "Unknown" <sip:3300138@192.168.42.91:5070;transport=udp>
Expires: 60
Max-Forwards: 70
User-Agent: IP Office 4.2 (23)
Content-Length: 0
30230mS CMARS: Case 1 - dial_delay_time: 4000 has expired - Resolve what we might have - Called Number: 625064811 Addr: ffcd3824
30231mS CMARS: FORM: awavoz - Received Number: 625064811
30232mS CMARS: FOUND A SHORT CODE - short_code: 6N; - Tel: 6N"@213.162.201.146" - Called_Party: 625064811@213.162.201.146 - Line Group Id: 99
30233mS CMARS: FindActiveARSByGroupID GroupID=99 - Not Found
30233mS CMLRQ: FindActiveLRQByGroupID GroupID=99 - Not Found
30233mS CMTARGET: Group Id: 99 has NOT been found in Line: 5
30234mS CMTARGET: Group Id: 99 has NOT been found in Line: 6
30234mS CMTARGET: Group Id: 99 has NOT been found in Line: 7
30235mS CMTARGET: Group Id: 99 has NOT been found in Line: 8
30235mS Sip: SIPTrunks: Make Target voip, line group id is 99 and ip 213.162.201.146
30237mS CMMap: a=3.1 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 1, total 16
30237mS Sip: License, Valid 1, Available 1, Consumed 0
30238mS CMCallEvt: 0.1013.0 -1 BaseEP: NEW CMEndpoint ffe25b20 TOTAL NOW=4 CALL_LIST=1
30240mS PRN: Created MH ffe24c98 parent 0.1013.0 -1 SIPTrunk Endpoint
30275mS CMARS: FOUND LINE - Line Id: 9 - using line group id: 99 - Called Number: 625064811@213.162.201.146 - Calling Number: 299
30275mS CMARS: SEND Setup TO LINE
30280mS CMCallEvt: 9.1013.0 4 SIPTrunk Endpoint: StateChange: END=child CMCSIdle->CMCSOffering
30286mS CMLineTx: v=0
CMSetup
Line: type=IPLine 9 Call: lid=9 id=1013 in=0
Called[625064811@213.162.201.146] Type=Default (100) Reason=CMDRdirect SndComp Calling[299] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=Inalambrico
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Inalambrico
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=299
IE CMIEDeviceDetail (231) LOCALE=esp HW=5 VER=4 class=CMDeviceStdPhone type=3 number=9 channel=0 rx_gain=32 tx_gain=32 ep_callid=1010 ipaddr=192.168.42.91 apps=0
IE CMIEMohSourceId (247) MOH Source = 255
IE CMIEFastStartInfoData (6)
Locale: esp
30287mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe25b20) received CMSetup
30287mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe24da4) CMSetup received, ep ffe26b98, dialog ffe24da4, dialling 625064811@213.162.201.146
30293mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe24da4) INVITE (method) SENT TO 213.162.201.146 5060 (reg 1 primary 0 secondary 0)
30295mS SIP Tx: UDP 192.168.42.91:5070 -> 213.162.201.146:5060
INVITE sip:625064811@213.162.201.146 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.91:5070;rport;branch=z9hG4bKedea2ca6a1808efec397220e7dba701a
From: "3300138" <sip:3300138@register.awavoz.com>;tag=24cc7a4da39330f1
To: <sip:625064811@213.162.201.146>
Call-ID: a5c3d19600c202bac9dfa19b21b200af@192.168.42.91
CSeq: 909205427 INVITE
Contact: "3300138" <sip:3300138@192.168.42.91:5070;transport=udp>
Max-Forwards: 70
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, INFO
Content-Type: application/sdp
Content-Length: 278
v=0
o=UserA 3223896317 520429584 IN IP4 192.168.42.91
s=Session SDP
c=IN IP4 192.168.42.91
t=0 0
m=audio 49152 RTP/AVP 18 8 0 101
a=rtpmap:18 G729/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=fmtp:18 annexb = no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
30298mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe24da4) UpdateSIPCallState SIPDialog::INITIAL(0) -> SIPDialog::INVITE_SENT(1)
30299mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe24da4) UpdateSDPState SIPDialog::IDLE(0) -> SIPDialog::OFFER_SENT(1)
30300mS CD: CALL: 0.1010.0 BState=Idle Cut=2 Music=0.0 Aend="Inalambrico(299)" (0.9) Bend="" [Line 9] (0.0) CalledNum=625064811 () CallingNum=299 (Inalambrico) Internal=1 Time=15378 AState=Dialling
30606mS RES: Wed 16/12/2009 12:21:22 FreeMem=2634372(2) CMMsg=4 (5) Buff=100 489 500 608 5 Links=10850
30606mS RES2: RTEngine=0, CMRTEngine=0, Timer=45, Poll=0, Ready=0, CMReady=0, CMQueue=0, VPNNQueue=0
31666mS ISDNL3Evt: v=5 p1=5,p2=1001,p3=5,p4=0,s1=
32298mS SIP Tx: UDP 192.168.42.91:5070 -> 213.162.201.146:5060
INVITE sip:625064811@213.162.201.146 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.91:5070;rport;branch=z9hG4bKedea2ca6a1808efec397220e7dba701a
From: "3300138" <sip:3300138@register.awavoz.com>;tag=24cc7a4da39330f1
To: <sip:625064811@213.162.201.146>
Call-ID: a5c3d19600c202bac9dfa19b21b200af@192.168.42.91
CSeq: 909205427 INVITE
Contact: "3300138" <sip:3300138@192.168.42.91:5070;transport=udp>
Max-Forwards: 70
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, INFO
Content-Type: application/sdp
Content-Length: 278
v=0
o=UserA 3223896317 520429584 IN IP4 192.168.42.91
s=Session SDP
c=IN IP4 192.168.42.91
t=0 0
m=audio 49152 RTP/AVP 18 8 0 101
a=rtpmap:18 G729/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=fmtp:18 annexb = no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
34298mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe24da4) PacketTimer expired, break the call
35299mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe24da4) EPTerminationTimeout, about to delete endpoint
35299mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe24da4) SIPDialog destructor ... ffe24da4
35301mS CMARS: LINE ep Received: CMReleaseComp - child->state = CMCSOffering - ARS Call State = CMCSOverlapRecv
35303mS CMCallEvt: 9.1013.0 -1 SIPTrunk Endpoint: StateChange: END=X CMCSOffering->CMCSCompleted
35304mS CMCallEvt: 9.1013.0 -1 SIPTrunk Endpoint: StateChange: END=X CMCSCompleted->CMCSDelete
35305mS CMARS: Target: Short_Code: 6N; - Line_Group_ID: 99 has been set to: CMARS_OUTOFSERVICE
35306mS CMCallEvt: 0.1012.0 4 ARS for awavoz: StateChange: END=B CMCSOverlapRecv->CMCSAccept
35306mS CMCallEvt: 0.1010.0 4 Inalambrico.0: StateChange: END=A CMCSDialling->CMCSRingBack
35307mS CMExtnEvt: v=1 State, new=Alerting old=Dialling,0,0,Inalambrico
35308mS CMExtnTx: v=299, p1=0
CMProgress
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
BChan: slot=0 chan=9
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLUser (0), pd=CMPDInbandPattern (8)
Display [WAITING_FOR_LINE]
Timed: 16/12/09 12:21
35308mS Sip: ~SipTrunkEndpoint 9.1013.0 -1 SIPTrunk Endpoint
35311mS CMCallEvt: 9.1013.0 -1 BaseEP: DELETE CMEndpoint ffe25b20 TOTAL NOW=3 CALL_LIST=1
35312mS CD: CALL: 0.1010.0 BState=Ringing Cut=3 Music=0.0 Aend="Inalambrico(299)" (0.9) Bend="" [] (0.0) CalledNum=625064811 () CallingNum=299 (Inalambrico) Internal=1 Time=20390 AState=Ringing
35316mS CMMap: a=6.6 b=0.0 DTMF::AllocateRAS allocated CMRTTonegen resource busy 6, total 8
35316mS CMMap: a=6.6 b=1.255 T
35316mS CMMap: PCG::MapBChan pcp[62]b1r0 cp_b ffd3483c other_cp_b ffd70068 type CGTypeDTMF
35317mS CMMap: a=6.6 b=0.9 M2
35317mS CMMap: DTMF:layTones g T[12] ,EEEEE
35318mS CMMap: Started playing tones, cp[62]b1r0 (from g null)
35318mS CMMap: cp[62]b1r0 SetOperGroup from g null to g null not executed, playing tones in progress ,EEEEE
35607mS RES: Wed 16/12/2009 12:21:27 FreeMem=2654908(2) CMMsg=4 (5) Buff=100 488 500 608 5 Links=10892
35608mS RES2: RTEngine=0, CMRTEngine=0, Timer=45, Poll=0, Ready=0, CMReady=0, CMQueue=0, VPNNQueue=0
36300mS SIP Tx: UDP 192.168.42.91:5070 -> 213.162.201.146:5060
INVITE sip:625064811@213.162.201.146 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.91:5070;rport;branch=z9hG4bKedea2ca6a1808efec397220e7dba701a
From: "3300138" <sip:3300138@register.awavoz.com>;tag=24cc7a4da39330f1
To: <sip:625064811@213.162.201.146>
Call-ID: a5c3d19600c202bac9dfa19b21b200af@192.168.42.91
CSeq: 909205427 INVITE
Contact: "3300138" <sip:3300138@192.168.42.91:5070;transport=udp>
Max-Forwards: 70
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, INFO
Content-Type: application/sdp
Content-Length: 278
v=0
o=UserA 3223896317 520429584 IN IP4 192.168.42.91
s=Session SDP
c=IN IP4 192.168.42.91
t=0 0
m=audio 49152 RTP/AVP 18 8 0 101
a=rtpmap:18 G729/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=fmtp:18 annexb = no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
36305mS CMARS: Retarget existing BUSY targets - Num of Busy Targets: 1 - Current Form: awavoz
37144mS CMMap: PCG::UnmapBChan pcp[62]b1r0 cp_b ffd3483c other_cp_b ffd70068
37145mS CMMap: a=6.6 b=0.9 M0
37146mS CMMap: a=6.6 b=0.0 T0
37146mS CMMap: a=6.6 b=0.0 DTMF::~DTMF freed CMRTTonegen resource busy 5, total 8
37147mS CMMap: a=6.6 b=0.0 DTMF::AllocateRAS allocated CMRTTonegen resource busy 6, total 8
37147mS CMMap: a=6.6 b=1.255 T
37148mS CMMap: PCG::MapBChan pcp[62]b1r0 cp_b ffd3483c other_cp_b ffd70068 type CGTypeDTMF
37148mS CMMap: a=6.6 b=0.9 M2
37149mS CMMap: DTMF:layTones g T[13] ,EEEEE
37149mS CMMap: Started playing tones, cp[62]b1r0 (from g null)
37150mS CMMap: cp[62]b1r0 SetOperGroup from g null to g null not executed, playing tones in progress ,EEEEE
38274mS CMExtnRx: v=299, p1=0
CMReleaseComp
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
38274mS CMCallEvt: 0.1010.0 4 Inalambrico.0: StateChange: END=A CMCSRingBack->CMCSCompleted
38275mS CMExtnEvt: v=1 State, new=PortRecoverDelay old=Alerting,0,0,Inalambrico
38279mS CMLOGGING: CALL:2009/12/1612:21,00:00:02,000,299,O,625064811,625064811,Inalambrico,,,1,,""n/a,0
38280mS CD: CALL: 0.1010.0 BState=Ringing Cut=2 Music=0.0 Aend="Inalambrico(299)" (0.9) Bend="" [] (0.0) CalledNum=625064811 () CallingNum=299 (Inalambrico) Internal=1 Time=23357 AState=Idle
38280mS CD: CALL: 0.1010.0 Deleted
38281mS CMExtnEvt: Inalambrico: CALL LOST (CMCauseNormal)
38281mS CMExtnEvt: Inalambrico: Extn(299) Calling Party Number(299) Type(CMNTypeInternal)
38282mS CMExtnEvt: Inalambrico: CMExtnHandler::SetCurrent( id: 1010->0 )
38282mS CMCallEvt: 0.1010.0 -1 Inalambrico.-1: StateChange: END=X CMCSCompleted->CMCSDelete
38283mS CMARS: CMARSEndpoint::CallLost(cause=16) - Address: 0.1012.0 4 ARS for awavoz - Call State: CMCSAccept
38284mS CMCallEvt: 0.1012.0 -1 ARS for awavoz: StateChange: END=X CMCSAccept->CMCSDelete
38285mS CMCallEvt: 0.1012.0 -1 BaseEP: DELETE CMEndpoint ffcd3824 TOTAL NOW=2 CALL_LIST=0
38285mS CMCallEvt: END CALL:4 (ffcfcdfc)
38287mS CMTARGET: 0.1010.0 -1 BaseEP: ~CMTargetHandler
38288mS CMCallEvt: 0.1010.0 -1 BaseEP: DELETE CMEndpoint ffcfd26c TOTAL NOW=1 CALL_LIST=0
38291mS CMMap: PCG::UnmapBChan pcp[62]b1r0 cp_b ffd3483c other_cp_b ffd70068
38292mS CMMap: a=6.6 b=0.9 M0
38292mS CMMap: a=6.6 b=0.0 T0
38293mS CMMap: a=6.6 b=0.0 DTMF::~DTMF freed CMRTTonegen resource busy 5, total 8
38295mS CMMap: a=3.1 b=0.0 Mapper::FreeCodec freed CMRTVocoder resource busy 0, total 16
Sip line does not work.
This is my Short code
6N
dial
6N
SIP
this is my ARS
6N;
dial
6N "@ 213,162,201,146"
Sip valid license.
I have set ip route 0.0.0.0 0.0.0.0 192.168.42.2 (this is my gateway)
in network lan 1 topology
Firewall type -> unknown
Ip public -> 88.12.183.211 -> My ip is not static
Public port ->
Online sip -> network setup
Layer 4 protocol -> UDP
use network topology info -> none
please help. I'm desperate. thanks
********** System (192.168.42.91) has been up and running for 14secs(14346mS) **********
********** Warning: TEXT File Logging selected **********
********** Warning: TEXT Logging to File STOPPED on 16/12/2009 12:21:06 **********
14347mS PRN: Monitor Started IP=192.168.42.52 IP 401 NG 4.2(23) 00E00701E73D
(IP Office: Supports Unicode, System Locale is esp)
14348mS PRN: LAW=A PRI=0, BRI=4, ALOG=4, ADSL=0 VCOMP=16, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=0 VMAIL=0(VER=0 TYP=1) CALLS=1(TOT=3)
14603mS RES: Wed 16/12/2009 12:21:06 FreeMem=2900712(2) CMMsg=2 (3) Buff=100 499 500 604 5 Links=587
14604mS RES2: RTEngine=0, CMRTEngine=0, Timer=49, Poll=0, Ready=0, CMReady=0, CMQueue=0, VPNNQueue=0
14671mS CMExtnRx: v=299, p1=0
CMReleaseComp
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
14672mS CMCallEvt: 0.1008.0 3 Inalambrico.0: StateChange: END=A CMCSDialling->CMCSCompleted
14674mS CMExtnEvt: v=1 State, new=PortRecoverDelay old=Dialling,0,0,Inalambrico
14681mS CMLOGGING: CALL:2009/12/1613:05,00:00:00,000,299,O,,,Inalambrico,,,1,,""n/a,0
14683mS CD: CALL: 0.1008.0 BState=Idle Cut=0 Music=0.0 Aend="Inalambrico(299)" (0.9) Bend="" [] (0.0) CalledNum= () CallingNum=299 (Inalambrico) Internal=1 Time=392 AState=Idle
14683mS CD: CALL: 0.1008.0 Deleted
14684mS CMExtnEvt: Inalambrico: CALL LOST (CMCauseNormal)
14685mS CMExtnEvt: Inalambrico: Extn(299) Calling Party Number(299) Type(CMNTypeInternal)
14685mS CMExtnEvt: Inalambrico: CMExtnHandler::SetCurrent( id: 1008->0 )
14686mS CMCallEvt: 0.1008.0 -1 Inalambrico.-1: StateChange: END=X CMCSCompleted->CMCSDelete
14688mS CMCallEvt: 0.1009.0 -1 BaseEP: DELETE CMEndpoint ffcfbdec TOTAL NOW=3 CALL_LIST=0
14688mS CMCallEvt: END CALL:3 (ffcfcdfc)
14693mS CMTARGET: 0.1008.0 -1 BaseEP: ~CMTargetHandler
14694mS CMCallEvt: 0.1008.0 -1 BaseEP: DELETE CMEndpoint ffcfd26c TOTAL NOW=2 CALL_LIST=0
14699mS CMMap: a=0.9 b=0.0 D0
14921mS CMCallEvt: 0.1010.0 -1 BaseEP: NEW CMEndpoint ffcfd26c TOTAL NOW=3 CALL_LIST=0
14922mS CMCallEvt: CREATE CALL:4 (ffcfcdfc)
14923mS CMCallEvt: 0.1011.0 -1 BaseEP: NEW CMEndpoint ffcfbdec TOTAL NOW=4 CALL_LIST=0
14937mS CMExtnEvt: Inalambrico: CMExtnHandler::SetCurrent( id: 0->1010 )
14938mS CMExtnEvt: v=1 State, new=Idle old=PortRecoverDelay,0,0,Inalambrico
14939mS CMExtnRx: v=299, p1=0
CMSetup
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[299] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
14940mS CMCallEvt: 0.1010.0 4 Inalambrico.0: StateChange: END=A CMCSIdle->CMCSDialInitiated
14941mS CMExtnEvt: v=1 State, new=Connected old=Idle,0,0,Inalambrico
14943mS CMTARGET: 0.1010.0 4 Inalambrico.0: LOOKUP CALL ROUTE: type=100 called_party= sub= calling=299 dir=out complete=0 ses=0
14944mS CMTARGET: 0.1010.0 4 Inalambrico.0: ADD TARGET (N): number= type=100 depth=1 nobar=1 setorig=1 ses=0
14947mS CMCallEvt: 0.1010.0 4 Inalambrico.0: StateChange: END=A CMCSDialInitiated->CMCSDialling
14948mS CMExtnEvt: v=1 State, new=Dialling old=Connected,0,0,Inalambrico
14949mS CMExtnTx: v=299, p1=0
CMSetupAck
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
BChan: slot=0 chan=9
UUI type=Local [......2Pd.] [0x01 0xff 0x00 0x00 0x01 0x02 0x32 0x50 0x64 0x00 ]
Timed: 16/12/09 12:21
14951mS CD: CALL: 0.1010.0 BState=Idle Cut=1 Music=3.0 Aend="Inalambrico(299)" (0.9) Bend="" [] (0.0) CalledNum= () CallingNum=299 (Inalambrico) Internal=1 Time=28 AState=DialInitiated
14959mS CMMap: a=0.9 b=0.0 D1
15117mS PRN: Sorting User List...
15118mS PRN: User List Sorted
15122mS PRN: Sorting Hunt Group List...
15123mS PRN: Local Hunt Group List Sorted
15127mS PRN: Sorting Directory List...
15128mS PRN: Sorted Directory List.
15130mS PRN: Created Tone MOH Source 1
15132mS PRN: Playing tone MOH Source 1
15135mS PRN: Config Write Completed
15200mS Sip: 0.1005.0 -1 SIPTrunk Endpoint(ffe24da4) EPTerminationTimeout, about to delete endpoint
15200mS Sip: 0.1005.0 -1 SIPTrunk Endpoint(ffe24da4) SIPDialog destructor ... ffe24da4
15201mS CMCallEvt: 0.1005.0 -1 SIPTrunk Endpoint: StateChange: END=X CMCSIdle->CMCSDelete
15201mS Sip: ~SipTrunkEndpoint 0.1005.0 -1 SIPTrunk Endpoint
15203mS CMCallEvt: 0.1005.0 -1 BaseEP: DELETE CMEndpoint ffe25b20 TOTAL NOW=3 CALL_LIST=1
16192mS SIP Tx: UDP 192.168.42.91:5070 -> 213.162.201.146:5060
REGISTER sip:register.awavoz.com SIP/2.0
Via: SIP/2.0/UDP 192.168.42.91:5070;rport;branch=z9hG4bKc9550e36631e9542d880402070592b65
From: sip:3300138@register.awavoz.com;tag=2c0ef06014b47afe
To: sip:3300138@register.awavoz.com
Call-ID: c7ce97e69f55ed353a4b3f54b0808e85@192.168.42.91
CSeq: 1433172533 REGISTER
Contact: "Unknown" <sip:3300138@192.168.42.91:5070;transport=udp>
Expires: 60
Max-Forwards: 70
User-Agent: IP Office 4.2 (23)
Content-Length: 0
16208mS ISDNL1Evt: v=6 peb=6,PHDI
16208mS ISDNL3Evt: v=6 p1=6,p2=1001,p3=4,p4=127,s1=
16209mS ISDNL1Evt: v=7 peb=7,PHDI
16209mS ISDNL3Evt: v=7 p1=7,p2=1001,p3=4,p4=127,s1=
16210mS ISDNL1Evt: v=8 peb=8,PHDI
16210mS ISDNL3Evt: v=8 p1=8,p2=1001,p3=4,p4=127,s1=
16213mS CMLineRx: v=6
CMLineDown
Line: type=Q931Line 6 Call: lid=0 id=-1 in=0
16213mS CMLineTx: v=6
CMRestart
Line: type=Q931Line 6 Call: lid=0 id=-1 in=0
16218mS CMTARGET: CMQ931Trunk:
reprocessInboundMsg - failure_timer set16219mS CMLineRx: v=7
CMLineDown
Line: type=Q931Line 7 Call: lid=0 id=-1 in=0
16219mS CMLineTx: v=7
CMRestart
Line: type=Q931Line 7 Call: lid=0 id=-1 in=0
16223mS CMTARGET: CMQ931Trunk:
reprocessInboundMsg - failure_timer set16225mS CMLineRx: v=8
CMLineDown
Line: type=Q931Line 8 Call: lid=0 id=-1 in=0
16225mS CMLineTx: v=8
CMRestart
Line: type=Q931Line 8 Call: lid=0 id=-1 in=0
16228mS PRN: ObjectMemoryPool: SSIComponentId, filled 4 times
16230mS CMTARGET: CMQ931Trunk:
reprocessInboundMsg - failure_timer set16232mS ISDNL1Evt: v=5 peb=5,PHDI
16232mS ISDNL3Evt: v=5 p1=5,p2=1001,p3=4,p4=127,s1=
16235mS CMLineRx: v=5
CMLineDown
Line: type=Q931Line 5 Call: lid=0 id=-1 in=0
16236mS CMLineTx: v=5
CMRestart
Line: type=Q931Line 5 Call: lid=0 id=-1 in=0
16240mS CMTARGET: CMQ931Trunk:
reprocessInboundMsg - failure_timer set16245mS ISDNL1Evt: v=8 peb=8,F4 F3
16245mS ISDNL1Evt: v=6 peb=6,F4 F3
16246mS ISDNL1Evt: v=7 peb=7,F4 F3
16337mS ISDNL1Evt: v=5 peb=5,F4 F3
16475mS ISDNL1Evt: v=5 peb=5,F5 F4
16477mS ISDNL1Evt: v=5 peb=5,F6 F5
16493mS ISDNL1Evt: v=5 peb=5,F7 F6
16493mS ISDNL1Evt: v=5 peb=5,PHAI
16514mS ISDNL3Evt: v=5 p1=5,p2=1000,p3=0,p4=0,s1=
16515mS CMLineRx: v=5
CMLineUp
Line: type=Q931Line 5 Call: lid=0 id=-1 in=0
16541mS CMLineRx: v=5
CMRestartAck
Line: type=Q931Line 5 Call: lid=0 id=-1 in=0
16795mS CMExtnEvt: Jose Manuel: ExtnFault now 0
16802mS CMExtnTx: v=203, p1=0
CMVoiceMailStatus
Line: type=DigitalExtn 3 Call: lid=0 id=-1 in=0
Called[Jose Manuel Msgs=0 Old=0 Sav=0] Type=Default (100) Reason=CMDRdirect Calling[00000000] Type=Default Plan=Default
Display [Jose Manuel Msgs=0]
Timed: 16/12/09 12:21
16892mS CMExtnEvt: Principal: ExtnFault now 0
16900mS CMExtnTx: v=201, p1=0
CMVoiceMailStatus
Line: type=DigitalExtn 3 Call: lid=0 id=-1 in=0
Called[Principal Msgs=0 Old=0 Sav=0] Type=Default (100) Reason=CMDRdirect Calling[00000000] Type=Default Plan=Default
Display [Principal Msgs=0]
Timed: 16/12/09 12:21
18800mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[6] Type=Default (100) Reason=CMDRdirect
18803mS CMMap: a=0.9 b=0.0 D0
19275mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[2] Type=Default (100) Reason=CMDRdirect
19632mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[5] Type=Default (100) Reason=CMDRdirect
20013mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[0] Type=Default (100) Reason=CMDRdirect
20193mS SIP Tx: UDP 192.168.42.91:5070 -> 213.162.201.146:5060
REGISTER sip:register.awavoz.com SIP/2.0
Via: SIP/2.0/UDP 192.168.42.91:5070;rport;branch=z9hG4bKc9550e36631e9542d880402070592b65
From: sip:3300138@register.awavoz.com;tag=2c0ef06014b47afe
To: sip:3300138@register.awavoz.com
Call-ID: c7ce97e69f55ed353a4b3f54b0808e85@192.168.42.91
CSeq: 1433172533 REGISTER
Contact: "Unknown" <sip:3300138@192.168.42.91:5070;transport=udp>
Expires: 60
Max-Forwards: 70
User-Agent: IP Office 4.2 (23)
Content-Length: 0
20534mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[6] Type=Default (100) Reason=CMDRdirect
21014mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[4] Type=Default (100) Reason=CMDRdirect
21414mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[8] Type=Default (100) Reason=CMDRdirect
21840mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[1] Type=Default (100) Reason=CMDRdirect
22222mS CMExtnRx: v=299, p1=0
CMInformation
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
Called[1] Type=Default (100) Reason=CMDRdirect
********** SysMonitor v7.0 (8) [connected to 192.168.42.91 (00E00701E73D)] **********
24316mS PRN: Monitor Status IP 401 NG 4.2(23)
24317mS PRN: LAW=A PRI=0, BRI=4, ALOG=4, ADSL=0 VCOMP=16, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=0 VMAIL=0(VER=0 TYP=1) CALLS=1(TOT=4)
24605mS RES: Wed 16/12/2009 12:21:16 FreeMem=2860732(2) CMMsg=2 (3) Buff=100 489 500 608 5 Links=143
24605mS RES2: RTEngine=0, CMRTEngine=0, Timer=47, Poll=0, Ready=0, CMReady=0, CMQueue=0, VPNNQueue=0
26224mS CMTARGET: 0.1010.0 4 Inalambrico.0: TimerExpired cause=CMTCDelayedProcessing
26225mS CMTARGET: 0.1010.0 4 Inalambrico.0: LOOKUP CALL ROUTE: type=100 called_party=625064811 sub= calling=299 dir=out complete=0 ses=0
26226mS CMTARGET: 0.1010.0 4 Inalambrico.0: ADD TARGET (N): number=625064811 type=100 depth=1 nobar=1 setorig=1 ses=0
26226mS CMTARGET: 0.1010.0 4 Inalambrico.0: USER SC: 625064811 2 25064811 sc=type=Dial code=6N, num=6N
26227mS CMARS: FindActiveARSByGroupID GroupID=51 - Found
26228mS CMARS: MakeCallTarget - Called Number: 625064811
26229mS CMCallEvt: 0.1012.0 -1 BaseEP: NEW CMEndpoint ffcd3824 TOTAL NOW=4 CALL_LIST=1
26229mS CMTARGET: 0.1010.0 4 Inalambrico.0: CancelTimer CMTCDialToneTimeout
26230mS CMTARGET: 0.1010.0 4 Inalambrico.0: INITIAL TARGETING SUCCEEDED
26230mS CMTARGET: 0.1010.0 4 Inalambrico.0: GetNoAnswerTimer:99
26232mS CMCallEvt: 0.1011.0 4 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
26233mS CMCallEvt: 0.1012.0 4 ARS for awavoz: StateChange: END=T CMCSIdle->CMCSOffering
26234mS CMCallEvt: 0.1011.0 4 TargetingEP: RequestEnd 0.1012.0 4 ARS for awavoz
26234mS CMTARGET: 0.1010.0 4 Inalambrico.0: CancelTimer CMTCNoAnswerTimeout
26235mS CMCallEvt: 0.1012.0 4 ARS for awavoz: StateChange: END=B CMCSOffering->CMCSOverlapRecv
26236mS CMARS: FORM: awavoz - Received Number: 625064811
26236mS CMARS: CMARSTargetingPending
26237mS CMCallEvt: 0.1011.0 -1 TargetingEP: StateChange: END=X CMCSOffering->CMCSDelete
26237mS CMCallEvt: 0.1011.0 -1 BaseEP: DELETE CMEndpoint ffcfbdec TOTAL NOW=3 CALL_LIST=1
26238mS CD: CALL: 0.1010.0 BState=Idle Cut=2 Music=0.0 Aend="Inalambrico(299)" (0.9) Bend="" [] (0.0) CalledNum=625064811 () CallingNum=299 (Inalambrico) Internal=1 Time=11316 AState=Dialling
26253mS ISDNL1Evt: v=8 peb=8,T3TO
26253mS ISDNL1Evt: v=8 peb=8,F3 F4
26253mS ISDNL1Evt: v=8 peb=8,PHDI
26253mS ISDNL3Evt: v=8 p1=8,p2=1001,p3=4,p4=127,s1=
26254mS ISDNL1Evt: v=6 peb=6,T3TO
26254mS ISDNL1Evt: v=6 peb=6,F3 F4
26254mS ISDNL1Evt: v=6 peb=6,PHDI
26255mS ISDNL3Evt: v=6 p1=6,p2=1001,p3=4,p4=127,s1=
26255mS ISDNL1Evt: v=7 peb=7,T3TO
26255mS ISDNL1Evt: v=7 peb=7,F3 F4
26256mS ISDNL1Evt: v=7 peb=7,PHDI
26256mS ISDNL3Evt: v=7 p1=7,p2=1001,p3=4,p4=127,s1=
26257mS CMLineRx: v=8
CMLineDown
Line: type=Q931Line 8 Call: lid=0 id=-1 in=0
26258mS CMTARGET: CMQ931Trunk:
reprocessInboundMsg - failure_timer set26259mS CMLineRx: v=6
CMLineDown
Line: type=Q931Line 6 Call: lid=0 id=-1 in=0
26259mS CMTARGET: CMQ931Trunk:
reprocessInboundMsg - failure_timer set26260mS CMLineRx: v=7
CMLineDown
Line: type=Q931Line 7 Call: lid=0 id=-1 in=0
26260mS CMTARGET: CMQ931Trunk:
reprocessInboundMsg - failure_timer set26477mS ISDNL1Evt: v=5 peb=5,Locked
28196mS SIP Tx: UDP 192.168.42.91:5070 -> 213.162.201.146:5060
REGISTER sip:register.awavoz.com SIP/2.0
Via: SIP/2.0/UDP 192.168.42.91:5070;rport;branch=z9hG4bKc9550e36631e9542d880402070592b65
From: sip:3300138@register.awavoz.com;tag=2c0ef06014b47afe
To: sip:3300138@register.awavoz.com
Call-ID: c7ce97e69f55ed353a4b3f54b0808e85@192.168.42.91
CSeq: 1433172533 REGISTER
Contact: "Unknown" <sip:3300138@192.168.42.91:5070;transport=udp>
Expires: 60
Max-Forwards: 70
User-Agent: IP Office 4.2 (23)
Content-Length: 0
30230mS CMARS: Case 1 - dial_delay_time: 4000 has expired - Resolve what we might have - Called Number: 625064811 Addr: ffcd3824
30231mS CMARS: FORM: awavoz - Received Number: 625064811
30232mS CMARS: FOUND A SHORT CODE - short_code: 6N; - Tel: 6N"@213.162.201.146" - Called_Party: 625064811@213.162.201.146 - Line Group Id: 99
30233mS CMARS: FindActiveARSByGroupID GroupID=99 - Not Found
30233mS CMLRQ: FindActiveLRQByGroupID GroupID=99 - Not Found
30233mS CMTARGET: Group Id: 99 has NOT been found in Line: 5
30234mS CMTARGET: Group Id: 99 has NOT been found in Line: 6
30234mS CMTARGET: Group Id: 99 has NOT been found in Line: 7
30235mS CMTARGET: Group Id: 99 has NOT been found in Line: 8
30235mS Sip: SIPTrunks: Make Target voip, line group id is 99 and ip 213.162.201.146
30237mS CMMap: a=3.1 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 1, total 16
30237mS Sip: License, Valid 1, Available 1, Consumed 0
30238mS CMCallEvt: 0.1013.0 -1 BaseEP: NEW CMEndpoint ffe25b20 TOTAL NOW=4 CALL_LIST=1
30240mS PRN: Created MH ffe24c98 parent 0.1013.0 -1 SIPTrunk Endpoint
30275mS CMARS: FOUND LINE - Line Id: 9 - using line group id: 99 - Called Number: 625064811@213.162.201.146 - Calling Number: 299
30275mS CMARS: SEND Setup TO LINE
30280mS CMCallEvt: 9.1013.0 4 SIPTrunk Endpoint: StateChange: END=child CMCSIdle->CMCSOffering
30286mS CMLineTx: v=0
CMSetup
Line: type=IPLine 9 Call: lid=9 id=1013 in=0
Called[625064811@213.162.201.146] Type=Default (100) Reason=CMDRdirect SndComp Calling[299] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ALaw
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=Inalambrico
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Inalambrico
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=299
IE CMIEDeviceDetail (231) LOCALE=esp HW=5 VER=4 class=CMDeviceStdPhone type=3 number=9 channel=0 rx_gain=32 tx_gain=32 ep_callid=1010 ipaddr=192.168.42.91 apps=0
IE CMIEMohSourceId (247) MOH Source = 255
IE CMIEFastStartInfoData (6)
Locale: esp
30287mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe25b20) received CMSetup
30287mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe24da4) CMSetup received, ep ffe26b98, dialog ffe24da4, dialling 625064811@213.162.201.146
30293mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe24da4) INVITE (method) SENT TO 213.162.201.146 5060 (reg 1 primary 0 secondary 0)
30295mS SIP Tx: UDP 192.168.42.91:5070 -> 213.162.201.146:5060
INVITE sip:625064811@213.162.201.146 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.91:5070;rport;branch=z9hG4bKedea2ca6a1808efec397220e7dba701a
From: "3300138" <sip:3300138@register.awavoz.com>;tag=24cc7a4da39330f1
To: <sip:625064811@213.162.201.146>
Call-ID: a5c3d19600c202bac9dfa19b21b200af@192.168.42.91
CSeq: 909205427 INVITE
Contact: "3300138" <sip:3300138@192.168.42.91:5070;transport=udp>
Max-Forwards: 70
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, INFO
Content-Type: application/sdp
Content-Length: 278
v=0
o=UserA 3223896317 520429584 IN IP4 192.168.42.91
s=Session SDP
c=IN IP4 192.168.42.91
t=0 0
m=audio 49152 RTP/AVP 18 8 0 101
a=rtpmap:18 G729/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=fmtp:18 annexb = no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
30298mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe24da4) UpdateSIPCallState SIPDialog::INITIAL(0) -> SIPDialog::INVITE_SENT(1)
30299mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe24da4) UpdateSDPState SIPDialog::IDLE(0) -> SIPDialog::OFFER_SENT(1)
30300mS CD: CALL: 0.1010.0 BState=Idle Cut=2 Music=0.0 Aend="Inalambrico(299)" (0.9) Bend="" [Line 9] (0.0) CalledNum=625064811 () CallingNum=299 (Inalambrico) Internal=1 Time=15378 AState=Dialling
30606mS RES: Wed 16/12/2009 12:21:22 FreeMem=2634372(2) CMMsg=4 (5) Buff=100 489 500 608 5 Links=10850
30606mS RES2: RTEngine=0, CMRTEngine=0, Timer=45, Poll=0, Ready=0, CMReady=0, CMQueue=0, VPNNQueue=0
31666mS ISDNL3Evt: v=5 p1=5,p2=1001,p3=5,p4=0,s1=
32298mS SIP Tx: UDP 192.168.42.91:5070 -> 213.162.201.146:5060
INVITE sip:625064811@213.162.201.146 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.91:5070;rport;branch=z9hG4bKedea2ca6a1808efec397220e7dba701a
From: "3300138" <sip:3300138@register.awavoz.com>;tag=24cc7a4da39330f1
To: <sip:625064811@213.162.201.146>
Call-ID: a5c3d19600c202bac9dfa19b21b200af@192.168.42.91
CSeq: 909205427 INVITE
Contact: "3300138" <sip:3300138@192.168.42.91:5070;transport=udp>
Max-Forwards: 70
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, INFO
Content-Type: application/sdp
Content-Length: 278
v=0
o=UserA 3223896317 520429584 IN IP4 192.168.42.91
s=Session SDP
c=IN IP4 192.168.42.91
t=0 0
m=audio 49152 RTP/AVP 18 8 0 101
a=rtpmap:18 G729/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=fmtp:18 annexb = no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
34298mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe24da4) PacketTimer expired, break the call
35299mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe24da4) EPTerminationTimeout, about to delete endpoint
35299mS Sip: 9.1013.0 4 SIPTrunk Endpoint(ffe24da4) SIPDialog destructor ... ffe24da4
35301mS CMARS: LINE ep Received: CMReleaseComp - child->state = CMCSOffering - ARS Call State = CMCSOverlapRecv
35303mS CMCallEvt: 9.1013.0 -1 SIPTrunk Endpoint: StateChange: END=X CMCSOffering->CMCSCompleted
35304mS CMCallEvt: 9.1013.0 -1 SIPTrunk Endpoint: StateChange: END=X CMCSCompleted->CMCSDelete
35305mS CMARS: Target: Short_Code: 6N; - Line_Group_ID: 99 has been set to: CMARS_OUTOFSERVICE
35306mS CMCallEvt: 0.1012.0 4 ARS for awavoz: StateChange: END=B CMCSOverlapRecv->CMCSAccept
35306mS CMCallEvt: 0.1010.0 4 Inalambrico.0: StateChange: END=A CMCSDialling->CMCSRingBack
35307mS CMExtnEvt: v=1 State, new=Alerting old=Dialling,0,0,Inalambrico
35308mS CMExtnTx: v=299, p1=0
CMProgress
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
BChan: slot=0 chan=9
IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLUser (0), pd=CMPDInbandPattern (8)
Display [WAITING_FOR_LINE]
Timed: 16/12/09 12:21
35308mS Sip: ~SipTrunkEndpoint 9.1013.0 -1 SIPTrunk Endpoint
35311mS CMCallEvt: 9.1013.0 -1 BaseEP: DELETE CMEndpoint ffe25b20 TOTAL NOW=3 CALL_LIST=1
35312mS CD: CALL: 0.1010.0 BState=Ringing Cut=3 Music=0.0 Aend="Inalambrico(299)" (0.9) Bend="" [] (0.0) CalledNum=625064811 () CallingNum=299 (Inalambrico) Internal=1 Time=20390 AState=Ringing
35316mS CMMap: a=6.6 b=0.0 DTMF::AllocateRAS allocated CMRTTonegen resource busy 6, total 8
35316mS CMMap: a=6.6 b=1.255 T
35316mS CMMap: PCG::MapBChan pcp[62]b1r0 cp_b ffd3483c other_cp_b ffd70068 type CGTypeDTMF
35317mS CMMap: a=6.6 b=0.9 M2
35317mS CMMap: DTMF:
layTones g T[12] ,EEEEE35318mS CMMap: Started playing tones, cp[62]b1r0 (from g null)
35318mS CMMap: cp[62]b1r0 SetOperGroup from g null to g null not executed, playing tones in progress ,EEEEE
35607mS RES: Wed 16/12/2009 12:21:27 FreeMem=2654908(2) CMMsg=4 (5) Buff=100 488 500 608 5 Links=10892
35608mS RES2: RTEngine=0, CMRTEngine=0, Timer=45, Poll=0, Ready=0, CMReady=0, CMQueue=0, VPNNQueue=0
36300mS SIP Tx: UDP 192.168.42.91:5070 -> 213.162.201.146:5060
INVITE sip:625064811@213.162.201.146 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.91:5070;rport;branch=z9hG4bKedea2ca6a1808efec397220e7dba701a
From: "3300138" <sip:3300138@register.awavoz.com>;tag=24cc7a4da39330f1
To: <sip:625064811@213.162.201.146>
Call-ID: a5c3d19600c202bac9dfa19b21b200af@192.168.42.91
CSeq: 909205427 INVITE
Contact: "3300138" <sip:3300138@192.168.42.91:5070;transport=udp>
Max-Forwards: 70
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, INFO
Content-Type: application/sdp
Content-Length: 278
v=0
o=UserA 3223896317 520429584 IN IP4 192.168.42.91
s=Session SDP
c=IN IP4 192.168.42.91
t=0 0
m=audio 49152 RTP/AVP 18 8 0 101
a=rtpmap:18 G729/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=fmtp:18 annexb = no
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
36305mS CMARS: Retarget existing BUSY targets - Num of Busy Targets: 1 - Current Form: awavoz
37144mS CMMap: PCG::UnmapBChan pcp[62]b1r0 cp_b ffd3483c other_cp_b ffd70068
37145mS CMMap: a=6.6 b=0.9 M0
37146mS CMMap: a=6.6 b=0.0 T0
37146mS CMMap: a=6.6 b=0.0 DTMF::~DTMF freed CMRTTonegen resource busy 5, total 8
37147mS CMMap: a=6.6 b=0.0 DTMF::AllocateRAS allocated CMRTTonegen resource busy 6, total 8
37147mS CMMap: a=6.6 b=1.255 T
37148mS CMMap: PCG::MapBChan pcp[62]b1r0 cp_b ffd3483c other_cp_b ffd70068 type CGTypeDTMF
37148mS CMMap: a=6.6 b=0.9 M2
37149mS CMMap: DTMF:
layTones g T[13] ,EEEEE37149mS CMMap: Started playing tones, cp[62]b1r0 (from g null)
37150mS CMMap: cp[62]b1r0 SetOperGroup from g null to g null not executed, playing tones in progress ,EEEEE
38274mS CMExtnRx: v=299, p1=0
CMReleaseComp
Line: type=AnalogueExtn 2 Call: lid=0 id=1 in=0
38274mS CMCallEvt: 0.1010.0 4 Inalambrico.0: StateChange: END=A CMCSRingBack->CMCSCompleted
38275mS CMExtnEvt: v=1 State, new=PortRecoverDelay old=Alerting,0,0,Inalambrico
38279mS CMLOGGING: CALL:2009/12/1612:21,00:00:02,000,299,O,625064811,625064811,Inalambrico,,,1,,""n/a,0
38280mS CD: CALL: 0.1010.0 BState=Ringing Cut=2 Music=0.0 Aend="Inalambrico(299)" (0.9) Bend="" [] (0.0) CalledNum=625064811 () CallingNum=299 (Inalambrico) Internal=1 Time=23357 AState=Idle
38280mS CD: CALL: 0.1010.0 Deleted
38281mS CMExtnEvt: Inalambrico: CALL LOST (CMCauseNormal)
38281mS CMExtnEvt: Inalambrico: Extn(299) Calling Party Number(299) Type(CMNTypeInternal)
38282mS CMExtnEvt: Inalambrico: CMExtnHandler::SetCurrent( id: 1010->0 )
38282mS CMCallEvt: 0.1010.0 -1 Inalambrico.-1: StateChange: END=X CMCSCompleted->CMCSDelete
38283mS CMARS: CMARSEndpoint::CallLost(cause=16) - Address: 0.1012.0 4 ARS for awavoz - Call State: CMCSAccept
38284mS CMCallEvt: 0.1012.0 -1 ARS for awavoz: StateChange: END=X CMCSAccept->CMCSDelete
38285mS CMCallEvt: 0.1012.0 -1 BaseEP: DELETE CMEndpoint ffcd3824 TOTAL NOW=2 CALL_LIST=0
38285mS CMCallEvt: END CALL:4 (ffcfcdfc)
38287mS CMTARGET: 0.1010.0 -1 BaseEP: ~CMTargetHandler
38288mS CMCallEvt: 0.1010.0 -1 BaseEP: DELETE CMEndpoint ffcfd26c TOTAL NOW=1 CALL_LIST=0
38291mS CMMap: PCG::UnmapBChan pcp[62]b1r0 cp_b ffd3483c other_cp_b ffd70068
38292mS CMMap: a=6.6 b=0.9 M0
38292mS CMMap: a=6.6 b=0.0 T0
38293mS CMMap: a=6.6 b=0.0 DTMF::~DTMF freed CMRTTonegen resource busy 5, total 8
38295mS CMMap: a=3.1 b=0.0 Mapper::FreeCodec freed CMRTVocoder resource busy 0, total 16
