We have a SIP paging server registered to an IP Office 9.0.3. the SIP server then sends the page to a multicast stream that is sent to a group of paging speakers (a mixture of Cyberdata and Algo devices). If we page from a digital phone (5410, 9504, or 9508) the audio is heard over the multicast stream on all speakers in the paging group. If we page from an H.323 phone (1616, 9611, or 9608) the audio is not heard through the multicast stream on our Cyberdata speakers in the paging group but is heard on the Algo paging horns in the same group. Does anyone have an idea of what to look for in the IP extension that would be causing the issue? The codec for the extensions and the SIP paging server are both G.711 u-law so it should be a codec issue.
Tek-Tips is the largest IT community on the Internet today!
Members share and learn making Tek-Tips Forums the best source of peer-reviewed technical information on the Internet!
-
Congratulations Chriss Miller on being selected by the Tek-Tips community for having the most helpful posts in the forums last week. Way to Go!
SIP paging with multicast
- Thread starter gregl45
- Start date
- Thread starter
- #3
- Thread starter
- #5
I have tried running traces in Monitor they look identical to me other than the extension numbers. I have included the races from both a digital phone that has audio on all speakers and an IP phone that doesn't have audio. Maybe you guys will see something.
[highlight #FCE94F]Trace from Digital Phone ext 201 Working on all speakers[/highlight]
13:31:30 257874965mS CMTARGET: 0.1601.0 173 Extn201.0: Setting Hard Timer 4000
13:31:30 257874965mS CMTARGET: 0.1601.0 173 Extn201.0: LOOKUP CALL ROUTE: type=100 called_party=*#299 sub= calling=201 dir=out complete=0 ses=0
13:31:30 257874965mS CMTARGET: 0.1601.0 173 Extn201.0: ADD TARGET (N): number=*#299 type=100 depth=1 nobar=1 setorig=1 ses=0
13:31:30 257874965mS CMTARGET: 0.1601.0 173 Extn201.0: SYS SC: *#299 5 299 sc=type=DialPaging code=*#xxx, num=N callinfop->sending_complete=0 secondary_dialtone=
13:31:30 257874966mS CMTARGET: 0.1601.0 173 Extn201.0: ADD TARGET (N): number=299 type=104 depth=2 nobar=1 setorig=1 ses=0
13:31:30 257874966mS CMTARGET: 0.1601.0 173 Extn201.0: SET USER: Paging Server orig=1
13:31:30 257874966mS CMTARGET: 0.1601.0 173 Extn201.0: ADD USER: Paging Server depth=2 disallow_cw=0 dnd=0 real_call=0 group_call=0 type(CMNTypePaging) incl(0x0) excpt(0x0), allow_redir(1) remote=00000000 simult 0 (0)
13:31:30 257874967mS CMCallEvt: 0.1603.0 -1 BaseEP: NEW CMEndpoint f4f0bac0 TOTAL NOW=3 CALL_LIST=1
13:31:30 257874967mS CMMap: a=0.18 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 1, total 10
13:31:30 257874967mS CMCallEvt: 0.1604.0 -1 BaseEP: NEW CMEndpoint f4eb2a70 TOTAL NOW=4 CALL_LIST=1
13:31:30 257874967mS CMCallEvt: 0.1604.0 -1 Paging Server.-1: NEW CMExtnEndpoint f4eb2a70, Name=Paging Server, Extn=299, Phys Extn=299
13:31:30 257874969mS CMTARGET: 252.1604.0 173 Paging Server.0: ADD PRIMARY
13:31:30 257874969mS CMTARGET: 0.1601.0 173 Extn201.0: CancelTimer CMTCDelayedProcessing
13:31:30 257874969mS CMTARGET: 0.1601.0 173 Extn201.0: INITIAL TARGETING SUCCEEDED
13:31:30 257874969mS CMTARGET: 0.1601.0 173 Extn201.0: GetNoAnswerTimer:15
13:31:30 257874970mS CMCallEvt: 0.1602.0 173 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
13:31:30 257874970mS CMCallEvt: 0.1603.0 173 PagingEP 299: StateChange: END=T CMCSIdle->CMCSOffering
13:31:30 257874971mS CMCallEvt: 252.1604.0 173 Paging Server.0: StateChange: END=T CMCSIdle->CMCSOffering
13:31:30 257874972mS CMExtnEvt: Paging Server: CMExtnHandler::SetCurrent( id: 0->1604 )
13:31:30 257874972mS CMExtnTx: v=299, p1=0
CMSetup
Line: type=SIPLine 260 Call: lid=252 id=1604 in=0
Called[299] Type=Paging (104) Reason=CMDRdirect Calling[201] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
CallingName.Invoke.CodePageISO8859-1
invokeId 14760
user 'Extn201' presentation Allowed
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEMediaWaitForConnect (16) CMIEMediaWaitForConnect
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=Extn201
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Extn201
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=201
IE CMIEDeviceDetail (231) LOCALE=enu HW=15 VER=9 class=CMDeviceStdPhone type=108 number=1 channel=0 features=0x10000420 rx_gain=32 tx_gain=32 ep_callid=1601 ipaddr=192.168.42.1 apps=0 loc=0 em_loc=1 features2=0x0
IE CMIEMohSourceId (247) MOH Source = 255
IE CMIESecurityData (253) 2 item(s)
Display [Extn201>299]
Timed: 15/11/18 13:31
Locale: enu
13:31:30 257874972mS Sip: SIPDialog f4f1bc98 created, dialogs 1
13:31:30 257874974mS Sip: 252.1604.0 173 Paging Server.0(f4f1bc98) SetLocalRTPAddress to 192.168.42.1:49152
13:31:30 257874975mS SIP Call Tx: phone
INVITE sip:299@192.168.42.50;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
Contact: "Extn201" <sip:201@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Content-Type: application/sdp
Supported: timer,100rel
User-Agent: IP Office 9.0.3.0 build 941
P-Asserted-Identity: "Extn201" <sip:201@192.168.42.1:5060>
Content-Length: 203
Call-Info: <sip:192.168.42.1:5060>; answer-after=0
v=0
o=UserA 537874623 1662954866 IN IP4 192.168.42.1
s=Session SDP
c=IN IP4 192.168.42.1
t=0 0
m=audio 49152 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
13:31:30 257874976mS SIP Tx: UDP 192.168.42.1:5060 -> 192.168.42.50:5060
INVITE sip:299@192.168.42.50;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
Contact: "Extn201" <sip:201@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Content-Type: application/sdp
Supported: timer,100rel
User-Agent: IP Office 9.0.3.0 build 941
P-Asserted-Identity: "Extn201" <sip:201@192.168.42.1:5060>
Content-Length: 203
Call-Info: <sip:192.168.42.1:5060>; answer-after=0
v=0
o=UserA 537874623 1662954866 IN IP4 192.168.42.1
s=Session SDP
c=IN IP4 192.168.42.1
t=0 0
m=audio 49152 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
13:31:30 257874976mS CD: CALL: 0.1601.0 BState=Idle Cut=0 Music=0.0 Aend="Extn201(201)" (0.1) Bend="Paging Server(299)" [Paging Server] (0.0) CalledNum=299 (Paging Server) CallingNum=201 (Extn201) Internal=1 Time=1498 AState=Dialling
13:31:30 257874981mS SIP Rx: UDP 192.168.42.50:5060 -> 192.168.42.1:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:31:30 257874982mS SIP Call Rx: phone
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:31:30 257874983mS CMExtnRx: v=299, p1=0
CMProceeding
Line: type=SIPLine 260 Call: lid=252 id=1604 in=0
13:31:30 257874983mS CMCallEvt: 0.1602.0 173 TargetingEP: RequestEnd 0.1603.0 173 PagingEP 299
13:31:30 257874983mS CMTARGET: 0.1601.0 173 Extn201.0: CancelTimer CMTCNoAnswerTimeout
13:31:30 257874983mS CMCallEvt: 0.1602.0 -1 BaseEP: DELETE CMEndpoint f4f14458 TOTAL NOW=3 CALL_LIST=1
13:31:30 257874984mS CMMap: PCGP g P[227] originCP_mp pcp[74]b1r0
13:31:30 257874984mS CMTARGET: CMPagingEndpoint 0.1603.0 173 PagingEP 299 RequestEnd, 1 targets
13:31:30 257874984mS CMCallEvt: 252.1604.0 173 Paging Server.0: StateChange: END=child CMCSOffering->CMCSAccept
13:31:32 257876006mS SIP Rx: UDP 192.168.42.50:5060 -> 192.168.42.1:5060
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
Contact: <sip:299@192.168.42.50:5060>
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:31:32 257876008mS SIP Call Rx: phone
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
Contact: <sip:299@192.168.42.50:5060>
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:31:32 257876008mS CMExtnRx: v=299, p1=0
CMAlerting
Line: type=SIPLine 260 Call: lid=252 id=1604 in=0
13:31:32 257876009mS CMCallEvt: 252.1604.0 173 Paging Server.0: StateChange: END=child CMCSAccept->CMCSRinging
13:31:32 257876009mS CMExtnEvt: v=0 State, new=Ringing old=Idle,0,0,Paging Server
13:31:32 257876010mS SIP Rx: UDP 192.168.42.50:5060 -> 192.168.42.1:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
Contact: <sip:299@192.168.42.50:5060>
Content-Type: application/sdp
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 182
v=0
o=299 123456 654321 IN IP4 192.168.42.50
s=A conversation
c=IN IP4 192.168.42.50
t=0 0
m=audio 10500 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
13:31:32 257876012mS SIP Call Rx: phone
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
Contact: <sip:299@192.168.42.50:5060>
Content-Type: application/sdp
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 182
v=0
o=299 123456 654321 IN IP4 192.168.42.50
s=A conversation
c=IN IP4 192.168.42.50
t=0 0
m=audio 10500 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
13:31:32 257876014mS SIP Call Tx: phone
ACK sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK67bdebf6c7ebef1398a9ced6d37006ea
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 ACK
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
13:31:32 257876014mS SIP Tx: UDP 192.168.42.1:5060 -> 192.168.42.50:5060
ACK sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK67bdebf6c7ebef1398a9ced6d37006ea
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 ACK
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
13:31:32 257876015mS Sip: 252.1604.0 173 Paging Server.0(f4f1bc98) SetRfc2833TxPayload: use RFC2833 for dtmf
13:31:32 257876015mS Sip: 252.1604.0 173 Paging Server.0(f4f1bc98) SetRemoteRTPAddress to 192.168.42.50:10500
13:31:32 257876016mS CMExtnRx: v=299, p1=0
CMConnect
Line: type=SIPLine 260 Call: lid=252 id=1604 in=0
Called[Extn201] Type=Default (100) Reason=CMDRdirect
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEFastStartInfoData (6) 2 item(s)
13:31:32 257876016mS CMCallEvt: 252.1604.0 173 Paging Server.0: StateChange: END=child CMCSRinging->CMCSConnReq
13:31:32 257876016mS CMExtnEvt: v=0 State, new=Connected old=Ringing,0,0,Paging Server
13:31:32 257876016mS CMCallEvt: 252.1604.0 173 Paging Server.0: StateChange: END=child CMCSConnReq->CMCSConnected
13:31:32 257876019mS CMExtnTx: v=299, p1=0
CMConnectAck
Line: type=SIPLine 260 Call: lid=252 id=1604 in=0
Timed: 15/11/18 13:31
13:31:32 257876019mS CMExtnTx: v=299, p1=0
CMFacility
Line: type=SIPLine 260 Call: lid=252 id=1604 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 15/11/18 13:31
13:31:32 257876020mS CMCallEvt: 0.1603.0 173 PagingEP 299: StateChange: END=B CMCSOffering->CMCSConnReq
13:31:32 257876020mS CMCallEvt: 0.1601.0 173 Extn201.0: StateChange: END=A CMCSDialling->CMCSOGConnReq
13:31:32 257876020mS CMExtnEvt: v=1 State, new=Connected old=Dialling,0,0,Extn201
13:31:32 257876021mS CMExtnTx: v=201, p1=0
CMConnect
Line: type=DigitalExtn 2 Call: lid=0 id=1601 in=0
Called[Extn201] Type=Default (100) Reason=CMDRdirect
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Paging Server
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=299
IE CMIEDeviceDetail (231) LOCALE=enu HW=15 VER=9 class=CMDevicePagingConference type=0 number=0 channel=0 features=0x1 rx_gain=32 tx_gain=32 ep_callid=1603 ipaddr=192.168.42.1 apps=0 loc=0 em_loc=0 features2=0x0
Timed: 15/11/18 13:31
13:31:32 257876021mS CMExtnRx: v=201, p1=0
CMConnectAck
Line: type=DigitalExtn 2 Call: lid=0 id=1601 in=0
13:31:32 257876021mS CMCallEvt: 0.1601.0 173 Extn201.0: StateChange: END=A CMCSOGConnReq->CMCSConnected
13:31:32 257876021mS CMTARGET: 0.1601.0 173 Extn201.0: ~CMTargetHandler f4f0d798 ep f4f163c8
13:31:32 257876022mS CMCallEvt: 0.1603.0 173 PagingEP 299: StateChange: END=B CMCSConnReq->CMCSConnected
13:31:32 257876024mS H323Evt: SetOperational 203 192.168.42.1:0 to 0
13:31:32 257876025mS H323Evt: SetRfc2833 203: (1) rx payload 101 tx payload 101
13:31:32 257876025mS CMMap: PCG::AddToneGenerator g P[227] for cp[393]b0r1 append pcp[394]b0r1 (total 2)
13:31:32 257876025mS CMMap: PCGP g P[227] created ip generator pcp[394]b0r1 ConfigureGenerator origin is ip 0
13:31:32 257876026mS CD: CALL: 0.1601.0 BState=Connected Cut=3 Music=0.0 Aend="Extn201(201)" (0.1) Bend="Paging Server(299)" [Paging Server(299)] (0.0) CalledNum=299 (Paging Server) CallingNum=201 (Extn201) Internal=1 Time=2547 AState=Connected
13:31:33 257877021mS CMMap: a=21.11 b=0.0 DTMF::AllocateRAS allocated CMRTVoicemail resource busy 2, total 45
13:31:33 257877021mS CMMap: a=21.11 b=1.65535 T
13:31:33 257877021mS CMMap: PCG::MapBChan pcp[74]b1r0 cp_b f5233228 other_cp_b f5698438 type CGTypeDTMF
13:31:33 257877021mS CMMap: a=21.11 b=0.1 M22
13:31:33 257877021mS CMMap: PCG::MapBChan pcp[394]b0r1 cp_b f56a1228 other_cp_b f5698438 type CGTypeDTMF
13:31:33 257877021mS CMMap: a=21.11 b=0.18 M22
13:31:33 257877021mS CMMap: PlatformConnectionAudioSAP::Bind pcp[394]b0r1 to 0.18
13:31:33 257877022mS CMMap: PlatformConnectionAudioSAP::ConnectVoice (connect) pcp[394]b0r1 echo_cancellation set to 0
13:31:33 257877022mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[394]b0r1 Configure 0.18
13:31:33 257877022mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[394]b0r1 ConnectIndication 0.18
13:31:33 257877022mS CMMap: DTMF:
layTones g T[228] xE
13:31:33 257877022mS CMMap: Started playing tones, P[227] (from g null)
13:31:33 257877022mS CMMap: P[227] SetOperGroup from g null to g null not executed, playing tones in progress xE
13:31:33 257877387mS CMMap: PCG::UnmapBChan pcp[394]b0r1 cp_b f56a1228 other_cp_b f5698438
13:31:33 257877387mS CMMap: a=21.11 b=0.18 M02
13:31:33 257877387mS CMMap: PCG::UnmapBChan pcp[74]b1r0 cp_b f5233228 other_cp_b f5698438
13:31:33 257877387mS CMMap: a=21.11 b=0.1 M02
13:31:33 257877388mS CMMap: PCG::UnmapBChan g P[227] cp_b 0 other_cp_b f5698438
13:31:33 257877388mS CMMap: a=21.11 b=0.0 T0
13:31:33 257877388mS CMMap: a=21.11 b=0.0 DTMF::~DTMF freed CMRTUnknown resource busy 1, total 45
13:31:33 257877389mS CMMap: PCGP g P[227] created ip generator pcp[394]b0r1 ConfigureGenerator origin is ip 0
13:31:33 257877389mS CMMap: PCGP g P[227] created ip generator pcp[394]b0r1 ConfigureGenerator origin is ip 0
13:31:33 257877389mS CMMap: PCGP g P[227] MapBChan cp_other pcp[74]b1r0 rtp_fwd_action ff src_fwd_action ff
13:31:33 257877389mS CMMap: a=0.1 b=0.18 M22
13:31:33 257877389mS CMMap: PCGP g P[227] created ip generator pcp[394]b0r1 ConfigureGenerator origin is ip 0
13:31:33 257877389mS CMMap: PCGP g P[227] MapBChan cp_other pcp[394]b0r1 rtp_fwd_action 8 src_fwd_action 2
13:31:33 257877389mS H323Evt: SetOperational 203 192.168.42.1:49152 to 1
13:31:33 257877390mS H323Evt: SetSendOnly 203 192.168.42.1:49152 to 1
13:31:34 257878147mS H323Evt: RTP(50t): 192.168.42.1/49152 192.168.42.50/10500 CODEC=Ulaw64K(5) PKTSZ=160 RFC2833=on AGE=2123 SENT=50 (avg size=160) RECV=0 (avg size=0)
13:31:37 257881228mS RES: Thu 15/11/2018 13:31:37 FreeMem=55230216 54519640(16) CachedMem=710576 CMMsg=8(9) Buff=5200 1358 1000 7443 5 Links=48149 BTree=14678 CPU=03.30% CPUStats=1/4/4357/18886/23147/0/0 MCR=0 MCW=0
13:31:37 257881228mS RES2: IP 500 V2 9.0.3.0 build 941 Tasks=50 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=62 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=18(TLS=2) TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
13:31:37 257881228mS RES4: XML MemObjs=61 PoolMem=2097152(1) FreeMem=2081872(1)
13:31:39 257883891mS CMExtnRx: v=201, p1=0
CMReleaseComp
Line: type=DigitalExtn 2 Call: lid=0 id=1601 in=0
13:31:39 257883891mS CMCallEvt: 0.1601.0 173 Extn201.0: StateChange: END=A CMCSConnected->CMCSCompleted
13:31:39 257883892mS CMExtnEvt: v=1 State, new=PortRecoverDelay old=Connected,0,0,Extn201
13:31:39 257883892mS CMLOGGING: CALL:2018/11/1513:31,00:00:07,000,201,O,299,*#299,Extn201,,,1,,""n/a,0
13:31:39 257883893mS CD: CALL: 0.1601.0 BState=Connected Cut=2 Music=0.0 Aend="EPaging Server(299)" (0.1) Bend="Paging Server(299)" [Paging Server(299)] (0.0) CalledNum=299 (Paging Server) CallingNum=201 (Extn201) Internal=1 Time=10414 AState=Idle
13:31:39 257883893mS CD: CALL: 0.1601.0 Deleted
13:31:39 257883893mS CMExtnEvt: Extn201: CALL LOST (CMCauseNormal)
13:31:39 257883893mS CMExtnEvt: Extn201: Extn(201) Calling Party Number(201) Type(CMNTypeInternal)
13:31:39 257883893mS CMExtnEvt: Extn201: CMExtnHandler::SetCurrent( id: 1601->0 )
13:31:39 257883893mS CMCallEvt: 0.1601.0 -1 Extn201.-1: StateChange: END=X CMCSCompleted->CMCSDelete
13:31:39 257883894mS CMExtnEvt: Paging Server: CALL LOST (CMCauseNormal)
13:31:39 257883894mS CMExtnEvt: Paging Server: Extn(299) Calling Party Number(201) Type(CMNTypeInternal)
13:31:39 257883894mS CMCallEvt: 252.1604.0 -1 Paging Server.0: StateChange: END=X CMCSConnected->CMCSCompleted
13:31:39 257883895mS CMExtnEvt: v=0 State, new=PortRecoverDelay old=Connected,0,0,Paging Server
13:31:39 257883895mS CMExtnTx: v=299, p1=0
CMReleaseComp
Line: type=SIPLine 260 Call: lid=252 id=1604 in=0
Called[299] Type=Paging (104) Reason=CMDRdirect Calling[201] Type=Internal Plan=Default
Cause=16, Normal call clearing
Timed: 15/11/18 13:31
13:31:39 257883897mS SIP Call Tx: phone
BYE sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bKf077231c12db02cb0e1250dbe77cf9d1
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468536 BYE
Contact: "Extn201" <sip:201@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Supported: timer,100rel
Reason: Q.850;cause=16;text="Normal call clearing"
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
13:31:39 257883897mS SIP Tx: UDP 192.168.42.1:5060 -> 192.168.42.50:5060
BYE sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bKf077231c12db02cb0e1250dbe77cf9d1
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468536 BYE
Contact: "Extn201" <sip:201@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Supported: timer,100rel
Reason: Q.850;cause=16;text="Normal call clearing"
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
[highlight #FCE94F]Trace from IP Phone ext 210 only owrks on Algo speakers not Cyberdata:[/highlight]
13:38:44 258307932mS CMTARGET: 254.1611.0 176 IP Phone.0: Setting Hard Timer 4000
13:38:44 258307932mS CMTARGET: 254.1611.0 176 IP Phone.0: LOOKUP CALL ROUTE: type=100 called_party=*#299 sub= calling=210 dir=out complete=0 ses=0
13:38:44 258307933mS CMTARGET: 254.1611.0 176 IP Phone.0: ADD TARGET (N): number=*#299 type=100 depth=1 nobar=1 setorig=1 ses=0
13:38:44 258307933mS CMTARGET: 254.1611.0 176 IP Phone.0: SYS SC: *#299 5 299 sc=type=DialPaging code=*#xxx, num=N callinfop->sending_complete=0 secondary_dialtone=
13:38:44 258307933mS CMTARGET: 254.1611.0 176 IP Phone.0: ADD TARGET (N): number=299 type=104 depth=2 nobar=1 setorig=1 ses=0
13:38:44 258307934mS CMTARGET: 254.1611.0 176 IP Phone.0: SET USER: Paging Server orig=1
13:38:44 258307934mS CMTARGET: 254.1611.0 176 IP Phone.0: ADD USER: Paging Server depth=2 disallow_cw=0 dnd=0 real_call=0 group_call=0 type(CMNTypePaging) incl(0x0) excpt(0x0), allow_redir(1) remote=00000000 simult 0 (0)
13:38:44 258307934mS CMCallEvt: 0.1613.0 -1 BaseEP: NEW CMEndpoint f4f0bac0 TOTAL NOW=3 CALL_LIST=1
13:38:44 258307934mS CMCallEvt: 0.1614.0 -1 BaseEP: NEW CMEndpoint f4eb2a70 TOTAL NOW=4 CALL_LIST=1
13:38:44 258307934mS CMCallEvt: 0.1614.0 -1 Paging Server.-1: NEW CMExtnEndpoint f4eb2a70, Name=Paging Server, Extn=299, Phys Extn=299
13:38:44 258307936mS CMTARGET: 252.1614.0 176 Paging Server.0: ADD PRIMARY
13:38:44 258307936mS CMTARGET: 254.1611.0 176 IP Phone.0: CancelTimer CMTCDelayedProcessing
13:38:44 258307936mS CMTARGET: 254.1611.0 176 IP Phone.0: INITIAL TARGETING SUCCEEDED
13:38:44 258307937mS CMTARGET: 254.1611.0 176 IP Phone.0: GetNoAnswerTimer:15
13:38:44 258307937mS CMCallEvt: 0.1612.0 176 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
13:38:44 258307938mS CMCallEvt: 0.1613.0 176 PagingEP 299: StateChange: END=T CMCSIdle->CMCSOffering
13:38:44 258307938mS CMCallEvt: 252.1614.0 176 Paging Server.0: StateChange: END=T CMCSIdle->CMCSOffering
13:38:44 258307939mS CMExtnEvt: Paging Server: CMExtnHandler::SetCurrent( id: 0->1614 )
13:38:44 258307939mS CMExtnTx: v=299, p1=0
CMSetup
Line: type=SIPLine 260 Call: lid=252 id=1614 in=0
Called[299] Type=Paging (104) Reason=CMDRdirect Calling[210] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
CallingName.Invoke.CodePageISO8859-1
invokeId 14762
user 'IP Phone' presentation Allowed
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEMediaWaitForConnect (16) CMIEMediaWaitForConnect
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=IP Phone
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=IP Phone
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=210
IE CMIEDeviceDetail (231) LOCALE=enu HW=15 VER=9 class=CMDeviceH323Phone type=39 number=8003 channel=0 features=0x10000420 rx_gain=32 tx_gain=32 ep_callid=1611 ipaddr=192.168.42.1 apps=0 loc=0 em_loc=0 features2=0x0
IE CMIEMohSourceId (247) MOH Source = 255
IE CMIESecurityData (253) 2 item(s)
Display [IP Phone>299]
Timed: 15/11/18 13:38
Locale: enu
13:38:44 258307939mS Sip: SIPDialog f4f1bc98 created, dialogs 1
13:38:44 258307941mS Sip: 252.1614.0 176 Paging Server.0(f4f1bc98) SetLocalRTPAddress to 192.168.42.1:49154
13:38:44 258307943mS SIP Call Tx: phone
INVITE sip:299@192.168.42.50;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
Contact: "IP Phone" <sip:210@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Content-Type: application/sdp
Supported: timer,100rel
User-Agent: IP Office 9.0.3.0 build 941
P-Asserted-Identity: "IP Phone" <sip:210@192.168.42.1:5060>
Content-Length: 202
Call-Info: <sip:192.168.42.1:5060>; answer-after=0
v=0
o=UserA 940663678 954463514 IN IP4 192.168.42.1
s=Session SDP
c=IN IP4 192.168.42.1
t=0 0
m=audio 49154 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
13:38:44 258307943mS SIP Tx: UDP 192.168.42.1:5060 -> 192.168.42.50:5060
INVITE sip:299@192.168.42.50;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
Contact: "IP Phone" <sip:210@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Content-Type: application/sdp
Supported: timer,100rel
User-Agent: IP Office 9.0.3.0 build 941
P-Asserted-Identity: "IP Phone" <sip:210@192.168.42.1:5060>
Content-Length: 202
Call-Info: <sip:192.168.42.1:5060>; answer-after=0
v=0
o=UserA 940663678 954463514 IN IP4 192.168.42.1
s=Session SDP
c=IN IP4 192.168.42.1
t=0 0
m=audio 49154 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
13:38:44 258307944mS CD: CALL: 254.1611.0 BState=Idle Cut=0 Music=0.0 Aend="IP Phone(210)" (0.0) Bend="Paging Server(299)" [Paging Server] (0.0) CalledNum=299 (Paging Server) CallingNum=210 (IP Phone) Internal=1 Time=2749 AState=Dialling
13:38:44 258307948mS SIP Rx: UDP 192.168.42.50:5060 -> 192.168.42.1:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:38:44 258307949mS SIP Call Rx: phone
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:38:44 258307950mS CMExtnRx: v=299, p1=0
CMProceeding
Line: type=SIPLine 260 Call: lid=252 id=1614 in=0
13:38:44 258307950mS CMCallEvt: 0.1612.0 176 TargetingEP: RequestEnd 0.1613.0 176 PagingEP 299
13:38:44 258307950mS CMTARGET: 254.1611.0 176 IP Phone.0: CancelTimer CMTCNoAnswerTimeout
13:38:44 258307950mS CMCallEvt: 0.1612.0 -1 BaseEP: DELETE CMEndpoint f4f14458 TOTAL NOW=3 CALL_LIST=1
13:38:44 258307951mS CMMap: PCGP g P[231] originCP_mp pcp[401]b0r1
13:38:44 258307951mS CMTARGET: CMPagingEndpoint 0.1613.0 176 PagingEP 299 RequestEnd, 1 targets
13:38:44 258307951mS CMCallEvt: 252.1614.0 176 Paging Server.0: StateChange: END=child CMCSOffering->CMCSAccept
13:38:45 258308967mS SIP Rx: UDP 192.168.42.50:5060 -> 192.168.42.1:5060
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
Contact: <sip:299@192.168.42.50:5060>
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:38:45 258308969mS SIP Call Rx: phone
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
Contact: <sip:299@192.168.42.50:5060>
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:38:45 258308970mS CMExtnRx: v=299, p1=0
CMAlerting
Line: type=SIPLine 260 Call: lid=252 id=1614 in=0
13:38:45 258308970mS CMCallEvt: 252.1614.0 176 Paging Server.0: StateChange: END=child CMCSAccept->CMCSRinging
13:38:45 258308970mS CMExtnEvt: v=0 State, new=Ringing old=Idle,0,0,Paging Server
13:38:45 258308971mS SIP Rx: UDP 192.168.42.50:5060 -> 192.168.42.1:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
Contact: <sip:299@192.168.42.50:5060>
Content-Type: application/sdp
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 182
v=0
o=299 123456 654321 IN IP4 192.168.42.50
s=A conversation
c=IN IP4 192.168.42.50
t=0 0
m=audio 10500 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
13:38:45 258308974mS SIP Call Rx: phone
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
Contact: <sip:299@192.168.42.50:5060>
Content-Type: application/sdp
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 182
v=0
o=299 123456 654321 IN IP4 192.168.42.50
s=A conversation
c=IN IP4 192.168.42.50
t=0 0
m=audio 10500 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
13:38:45 258308976mS SIP Call Tx: phone
ACK sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK2b44526c104c2cf1c8bae1a2b0151b91
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 ACK
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
13:38:45 258308976mS SIP Tx: UDP 192.168.42.1:5060 -> 192.168.42.50:5060
ACK sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK2b44526c104c2cf1c8bae1a2b0151b91
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 ACK
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
13:38:45 258308976mS Sip: 252.1614.0 176 Paging Server.0(f4f1bc98) SetRfc2833TxPayload: use RFC2833 for dtmf
13:38:45 258308977mS Sip: 252.1614.0 176 Paging Server.0(f4f1bc98) SetRemoteRTPAddress to 192.168.42.50:10500
13:38:45 258308977mS CMExtnRx: v=299, p1=0
CMConnect
Line: type=SIPLine 260 Call: lid=252 id=1614 in=0
Called[IP Phone] Type=Default (100) Reason=CMDRdirect
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEFastStartInfoData (6) 2 item(s)
13:38:45 258308977mS CMCallEvt: 252.1614.0 176 Paging Server.0: StateChange: END=child CMCSRinging->CMCSConnReq
13:38:45 258308977mS CMExtnEvt: v=0 State, new=Connected old=Ringing,0,0,Paging Server
13:38:45 258308978mS CMCallEvt: 252.1614.0 176 Paging Server.0: StateChange: END=child CMCSConnReq->CMCSConnected
13:38:45 258308981mS CMExtnTx: v=299, p1=0
CMConnectAck
Line: type=SIPLine 260 Call: lid=252 id=1614 in=0
Timed: 15/11/18 13:38
13:38:45 258308981mS CMExtnTx: v=299, p1=0
CMFacility
Line: type=SIPLine 260 Call: lid=252 id=1614 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 15/11/18 13:38
13:38:45 258308982mS CMCallEvt: 0.1613.0 176 PagingEP 299: StateChange: END=B CMCSOffering->CMCSConnReq
13:38:45 258308982mS CMCallEvt: 254.1611.0 176 IP Phone.0: StateChange: END=A CMCSDialling->CMCSOGConnReq
13:38:45 258308982mS CMExtnEvt: v=5 State, new=Connected old=Dialling,0,0,IP Phone
13:38:45 258308983mS CMExtnTx: v=210, p1=0
CMConnect
Line: type=IPLine 250 Call: lid=254 id=1611 in=0
Called[IP Phone] Type=Default (100) Reason=CMDRdirect
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Paging Server
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=299
IE CMIEDeviceDetail (231) LOCALE=enu HW=15 VER=9 class=CMDevicePagingConference type=0 number=0 channel=0 features=0x1 rx_gain=32 tx_gain=32 ep_callid=1613 ipaddr=192.168.42.1 apps=0 loc=0 em_loc=0 features2=0x0
Timed: 15/11/18 13:38
13:38:45 258308983mS CMExtnRx: v=210, p1=0
CMConnectAck
Line: type=IPLine 250 Call: lid=254 id=1611 in=0
13:38:45 258308983mS CMCallEvt: 254.1611.0 176 IP Phone.0: StateChange: END=A CMCSOGConnReq->CMCSConnected
13:38:45 258308984mS CMTARGET: 254.1611.0 176 IP Phone.0: ~CMTargetHandler f4f0d798 ep f4f163c8
13:38:45 258308985mS CMCallEvt: 0.1613.0 176 PagingEP 299: StateChange: END=B CMCSConnReq->CMCSConnected
13:38:45 258308989mS H323Evt: SetOperational 208 192.168.42.1:0 to 0
13:38:45 258308989mS H323Evt: SetRfc2833 208: (1) rx payload 101 tx payload 101
13:38:46 258309982mS CD: CALL: 254.1611.0 BState=Connected Cut=3 Music=0.0 Aend="IP Phone(210)" (0.0) Bend="Paging Server(299)" [Paging Server(299)] (0.0) CalledNum=299 (Paging Server) CallingNum=210 (IP Phone) Internal=1 Time=4788 AState=Connected
13:38:46 258309983mS CMMap: a=21.11 b=0.0 DTMF::AllocateRAS allocated CMRTVoicemail resource busy 2, total 45
13:38:46 258309983mS CMMap: a=21.11 b=1.65535 T
13:38:46 258309983mS CMMap: PCG::AddToneGenerator g T[232] for cp[401]b0r1 append pcp[404]b0r1 (total 1)
13:38:46 258309983mS CMMap: a=0.18 b=0.0 IP::ReserveCodec pcp[404]b0r1 allocated CMRTVocoder resource busy 1, total 10, codec type 5
13:38:46 258309983mS CMMap: a=21.11 b=0.18 M22
13:38:46 258309984mS CMMap: PlatformConnectionAudioSAP::Bind pcp[404]b0r1 to 0.18
13:38:46 258309984mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[404]b0r1 Configure 0.18
13:38:46 258309984mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[404]b0r1 ConnectIndication 0.18
13:38:46 258309984mS CMMap: PCG::MapBChan pcp[401]b0r1 cp_b 0 other_cp_b 0 type CGTypeDTMF
13:38:46 258309984mS H323Evt: SetOperational 207 192.168.42.1:49152 to 1
13:38:46 258309985mS H323Evt: SetOperational 208 192.168.42.1:49154 to 1
13:38:46 258309985mS H323Evt: SetSendOnly 208 192.168.42.1:49154 to 1
13:38:46 258309985mS CMMap: DTMF:layTones g T[232] xE
13:38:46 258309985mS CMMap: Started playing tones, P[231] (from g null)
13:38:46 258309985mS CMMap: P[231] SetOperGroup from g null to g null not executed, playing tones in progress xE
13:38:47 258310350mS H323Evt: SetOperational 208 192.168.42.1:49154 to 0
13:38:47 258310350mS H323Evt: SetSendOnly 208 192.168.42.1:49154 to 0
13:38:47 258310350mS H323Evt: SetOperational 207 192.168.42.1:49152 to 0
13:38:47 258310350mS CMMap: PCG::UnmapBChan pcp[404]b0r1 cp_b f56a1228 other_cp_b f5698438
13:38:47 258310350mS CMMap: a=21.11 b=0.18 M02
13:38:47 258310351mS CMMap: PCG::UnmapBChan g P[231] cp_b 0 other_cp_b f5698438
13:38:47 258310351mS CMMap: a=21.11 b=0.0 T0
13:38:47 258310351mS CMMap: a=21.11 b=0.0 DTMF::~DTMF freed CMRTUnknown resource busy 1, total 45
13:38:47 258310352mS CMMap: PCGP g P[231] MapBChan cp_other pcp[401]b0r1 rtp_fwd_action 3 src_fwd_action 8
13:38:47 258310352mS H323Evt: SetOperational 208 192.168.42.1:49154 to 1
13:38:47 258310352mS H323Evt: SetSendOnly 208 192.168.42.1:49154 to 1
13:38:47 258310352mS H323Evt: SetOperational 207 192.168.42.1:49152 to 1
13:38:47 258310353mS CMMap: a=0.18 b=0.0 IP::FreeCodec pcp[404]b0r1 freed CMRTVocoder resource busy 1, total 10
13:38:47 258310646mS RES: Thu 15/11/2018 13:38:47 FreeMem=55185912 54486832(15) CachedMem=699080 CMMsg=8(9) Buff=5200 1358 1000 7444 5 Links=48185 BTree=14678 CPU=05.84% CPUStats=3/7/4357/18061/23147/0/0 MCR=0 MCW=0
13:38:47 258310647mS RES2: IP 500 V2 9.0.3.0 build 941 Tasks=50 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=64 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=18(TLS=2) TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
13:38:47 258310647mS RES4: XML MemObjs=61 PoolMem=2097152(1) FreeMem=2081872(1)
13:38:48 258311173mS H323Evt: RTP(50t): 192.168.42.1/49154 192.168.42.50/10500 CODEC=Ulaw64K(5) PKTSZ=160 RFC2833=on AGE=2184 SENT=50 (avg size=163) RECV=0 (avg size=0)
13:38:49 258312672mS SIP Rx: UDP 192.168.42.50:5060 -> 192.168.42.1:5060
REGISTER sip:192.168.42.1 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.50:5060;rport;branch=z9hG4bK934463200
From: <sip:299@192.168.42.1>;tag=3932896046
To: <sip:299@192.168.42.1>
Call-ID: 1617665463
CSeq: 985 REGISTER
Contact: <sip:299@192.168.42.50:5060;line=48b17be0e0b4468>
Authorization: Digest username="299", realm="ipoffice", nonce="c407cf091fe59fdcfd32", uri="sip:192.168.42.1", response="ab0910e8c53d473b2138c1d1ac4258ff", algorithm=MD5
Max-Forwards: 70
User-Agent: Cyberdata Paging Server v7.2.0
Expires: 180
Content-Length: 0
13:38:49 258312674mS SIP Reg/Opt Rx: phone
REGISTER sip:192.168.42.1 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.50:5060;rport;branch=z9hG4bK934463200
From: <sip:299@192.168.42.1>;tag=3932896046
To: <sip:299@192.168.42.1>
Call-ID: 1617665463
CSeq: 985 REGISTER
Contact: <sip:299@192.168.42.50:5060;line=48b17be0e0b4468>
Authorization: Digest username="299", realm="ipoffice", nonce="c407cf091fe59fdcfd32", uri="sip:192.168.42.1", response="ab0910e8c53d473b2138c1d1ac4258ff", algorithm=MD5
Max-Forwards: 70
User-Agent: Cyberdata Paging Server v7.2.0
Expires: 180
Content-Length: 0
13:38:49 258312675mS Sip: SIPDialog f4f4ba50 created, dialogs 2
13:38:49 258312676mS SIP Reg/Opt Tx: phone
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.42.50:5060;rport;branch=z9hG4bK934463200
From: <sip:299@192.168.42.1>;tag=3932896046
Call-ID: 1617665463
CSeq: 985 REGISTER
User-Agent: IP Office 9.0.3.0 build 941
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:299@192.168.42.50:5060;line=48b17be0e0b4468>
Date: Thu, 15 Nov 2018 20:38:49 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.3.0 build 941
To: <sip:299@192.168.42.1>;tag=6747b3824b43889a
Content-Length: 0
13:38:49 258312677mS SIP Tx: UDP 192.168.42.1:5060 -> 192.168.42.50:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.42.50:5060;rport;branch=z9hG4bK934463200
From: <sip:299@192.168.42.1>;tag=3932896046
Call-ID: 1617665463
CSeq: 985 REGISTER
User-Agent: IP Office 9.0.3.0 build 941
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:299@192.168.42.50:5060;line=48b17be0e0b4468>
Date: Thu, 15 Nov 2018 20:38:49 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.3.0 build 941
To: <sip:299@192.168.42.1>;tag=6747b3824b43889a
Content-Length: 0
13:38:49 258312677mS Sip: SIPDialog f4f4ba50 deleted, dialogs 1
********** SysMonitor v9.0.3.0 build 941 [connected to 192.168.42.1 (Default IP Page)] **********
13:38:50 258314572mS PRN: Monitor Status IP 500 V2 9.0.3.0 build 941
13:38:50 258314572mS PRN: LAW=U PRI=0, BRI=0, ALOG=4, VCOMP=10, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=0 VMAIL=1(VER=2 TYP=3) 1-X=0 CALLS=1(TOT=176)
13:38:52 258316826mS CMExtnTx: v=210, p1=8003
CMFacility
Line: type=IPLine 250 Call: lid=254 id=5 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
13:38:52 258316826mS CMExtnRx: v=210, p1=0
CMReleaseComp
Line: type=IPLine 250 Call: lid=254 id=1611 in=0
13:38:52 258316826mS CMCallEvt: 254.1611.0 176 IP Phone.0: StateChange: END=A CMCSConnected->CMCSCompleted
13:38:52 258316827mS CMExtnEvt: v=5 State, new=PortRecoverDelay old=Connected,0,0,IP Phone
13:38:52 258316829mS CMExtnTx: v=210, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=254 id=1611 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 15/11/18 13:38
13:38:52 258316829mS CMLOGGING: CALL:2018/11/1513:38,00:00:07,000,210,O,299,*#299,IPPhone,,,1,,""n/a,0
13:38:52 258316830mS CD: CALL: 254.1611.0 BState=Connected Cut=2 Music=0.0 Aend="IPaging Server(299)" (0.0) Bend="Paging Server(299)" [Paging Server(299)] (0.0) CalledNum=299 (Paging Server) CallingNum=210 (IP Phone) Internal=1 Time=11635 AState=Idle
13:38:52 258316830mS CD: CALL: 254.1611.0 Deleted
13:38:52 258316831mS CMExtnEvt: IP Phone: CALL LOST (CMCauseNormal)
13:38:52 258316831mS CMExtnEvt: IP Phone: Extn(210) Calling Party Number(210) Type(CMNTypeInternal)
13:38:52 258316831mS CMExtnEvt: IP Phone: CMExtnHandler::SetCurrent( id: 1611->0 )
13:38:52 258316832mS CMCallEvt: 254.1611.0 -1 IP Phone.-1: StateChange: END=X CMCSCompleted->CMCSDelete
13:38:52 258316832mS CMExtnEvt: Paging Server: CALL LOST (CMCauseNormal)
13:38:52 258316833mS CMExtnEvt: Paging Server: Extn(299) Calling Party Number(210) Type(CMNTypeInternal)
13:38:52 258316833mS CMCallEvt: 252.1614.0 -1 Paging Server.0: StateChange: END=X CMCSConnected->CMCSCompleted
13:38:52 258316833mS CMExtnEvt: v=0 State, new=PortRecoverDelay old=Connected,0,0,Paging Server
13:38:52 258316834mS CMExtnTx: v=299, p1=0
CMReleaseComp
Line: type=SIPLine 260 Call: lid=252 id=1614 in=0
Called[299] Type=Paging (104) Reason=CMDRdirect Calling[210] Type=Internal Plan=Default
Cause=16, Normal call clearing
Timed: 15/11/18 13:38
13:38:52 258316835mS SIP Call Tx: phone
BYE sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK43dd2090697f51e8875006066c54cca8
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985057 BYE
Contact: "IP Phone" <sip:210@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Supported: timer,100rel
Reason: Q.850;cause=16;text="Normal call clearing"
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
13:38:52 258316835mS SIP Tx: UDP 192.168.42.1:5060 -> 192.168.42.50:5060
BYE sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK43dd2090697f51e8875006066c54cca8
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985057 BYE
Contact: "IP Phone" <sip:210@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Supported: timer,100rel
Reason: Q.850;cause=16;text="Normal call clearing"
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
[highlight #FCE94F]Trace from Digital Phone ext 201 Working on all speakers[/highlight]
13:31:30 257874965mS CMTARGET: 0.1601.0 173 Extn201.0: Setting Hard Timer 4000
13:31:30 257874965mS CMTARGET: 0.1601.0 173 Extn201.0: LOOKUP CALL ROUTE: type=100 called_party=*#299 sub= calling=201 dir=out complete=0 ses=0
13:31:30 257874965mS CMTARGET: 0.1601.0 173 Extn201.0: ADD TARGET (N): number=*#299 type=100 depth=1 nobar=1 setorig=1 ses=0
13:31:30 257874965mS CMTARGET: 0.1601.0 173 Extn201.0: SYS SC: *#299 5 299 sc=type=DialPaging code=*#xxx, num=N callinfop->sending_complete=0 secondary_dialtone=
13:31:30 257874966mS CMTARGET: 0.1601.0 173 Extn201.0: ADD TARGET (N): number=299 type=104 depth=2 nobar=1 setorig=1 ses=0
13:31:30 257874966mS CMTARGET: 0.1601.0 173 Extn201.0: SET USER: Paging Server orig=1
13:31:30 257874966mS CMTARGET: 0.1601.0 173 Extn201.0: ADD USER: Paging Server depth=2 disallow_cw=0 dnd=0 real_call=0 group_call=0 type(CMNTypePaging) incl(0x0) excpt(0x0), allow_redir(1) remote=00000000 simult 0 (0)
13:31:30 257874967mS CMCallEvt: 0.1603.0 -1 BaseEP: NEW CMEndpoint f4f0bac0 TOTAL NOW=3 CALL_LIST=1
13:31:30 257874967mS CMMap: a=0.18 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder resource busy 1, total 10
13:31:30 257874967mS CMCallEvt: 0.1604.0 -1 BaseEP: NEW CMEndpoint f4eb2a70 TOTAL NOW=4 CALL_LIST=1
13:31:30 257874967mS CMCallEvt: 0.1604.0 -1 Paging Server.-1: NEW CMExtnEndpoint f4eb2a70, Name=Paging Server, Extn=299, Phys Extn=299
13:31:30 257874969mS CMTARGET: 252.1604.0 173 Paging Server.0: ADD PRIMARY
13:31:30 257874969mS CMTARGET: 0.1601.0 173 Extn201.0: CancelTimer CMTCDelayedProcessing
13:31:30 257874969mS CMTARGET: 0.1601.0 173 Extn201.0: INITIAL TARGETING SUCCEEDED
13:31:30 257874969mS CMTARGET: 0.1601.0 173 Extn201.0: GetNoAnswerTimer:15
13:31:30 257874970mS CMCallEvt: 0.1602.0 173 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
13:31:30 257874970mS CMCallEvt: 0.1603.0 173 PagingEP 299: StateChange: END=T CMCSIdle->CMCSOffering
13:31:30 257874971mS CMCallEvt: 252.1604.0 173 Paging Server.0: StateChange: END=T CMCSIdle->CMCSOffering
13:31:30 257874972mS CMExtnEvt: Paging Server: CMExtnHandler::SetCurrent( id: 0->1604 )
13:31:30 257874972mS CMExtnTx: v=299, p1=0
CMSetup
Line: type=SIPLine 260 Call: lid=252 id=1604 in=0
Called[299] Type=Paging (104) Reason=CMDRdirect Calling[201] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
CallingName.Invoke.CodePageISO8859-1
invokeId 14760
user 'Extn201' presentation Allowed
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEMediaWaitForConnect (16) CMIEMediaWaitForConnect
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=Extn201
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Extn201
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=201
IE CMIEDeviceDetail (231) LOCALE=enu HW=15 VER=9 class=CMDeviceStdPhone type=108 number=1 channel=0 features=0x10000420 rx_gain=32 tx_gain=32 ep_callid=1601 ipaddr=192.168.42.1 apps=0 loc=0 em_loc=1 features2=0x0
IE CMIEMohSourceId (247) MOH Source = 255
IE CMIESecurityData (253) 2 item(s)
Display [Extn201>299]
Timed: 15/11/18 13:31
Locale: enu
13:31:30 257874972mS Sip: SIPDialog f4f1bc98 created, dialogs 1
13:31:30 257874974mS Sip: 252.1604.0 173 Paging Server.0(f4f1bc98) SetLocalRTPAddress to 192.168.42.1:49152
13:31:30 257874975mS SIP Call Tx: phone
INVITE sip:299@192.168.42.50;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
Contact: "Extn201" <sip:201@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Content-Type: application/sdp
Supported: timer,100rel
User-Agent: IP Office 9.0.3.0 build 941
P-Asserted-Identity: "Extn201" <sip:201@192.168.42.1:5060>
Content-Length: 203
Call-Info: <sip:192.168.42.1:5060>; answer-after=0
v=0
o=UserA 537874623 1662954866 IN IP4 192.168.42.1
s=Session SDP
c=IN IP4 192.168.42.1
t=0 0
m=audio 49152 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
13:31:30 257874976mS SIP Tx: UDP 192.168.42.1:5060 -> 192.168.42.50:5060
INVITE sip:299@192.168.42.50;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
Contact: "Extn201" <sip:201@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Content-Type: application/sdp
Supported: timer,100rel
User-Agent: IP Office 9.0.3.0 build 941
P-Asserted-Identity: "Extn201" <sip:201@192.168.42.1:5060>
Content-Length: 203
Call-Info: <sip:192.168.42.1:5060>; answer-after=0
v=0
o=UserA 537874623 1662954866 IN IP4 192.168.42.1
s=Session SDP
c=IN IP4 192.168.42.1
t=0 0
m=audio 49152 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
13:31:30 257874976mS CD: CALL: 0.1601.0 BState=Idle Cut=0 Music=0.0 Aend="Extn201(201)" (0.1) Bend="Paging Server(299)" [Paging Server] (0.0) CalledNum=299 (Paging Server) CallingNum=201 (Extn201) Internal=1 Time=1498 AState=Dialling
13:31:30 257874981mS SIP Rx: UDP 192.168.42.50:5060 -> 192.168.42.1:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:31:30 257874982mS SIP Call Rx: phone
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:31:30 257874983mS CMExtnRx: v=299, p1=0
CMProceeding
Line: type=SIPLine 260 Call: lid=252 id=1604 in=0
13:31:30 257874983mS CMCallEvt: 0.1602.0 173 TargetingEP: RequestEnd 0.1603.0 173 PagingEP 299
13:31:30 257874983mS CMTARGET: 0.1601.0 173 Extn201.0: CancelTimer CMTCNoAnswerTimeout
13:31:30 257874983mS CMCallEvt: 0.1602.0 -1 BaseEP: DELETE CMEndpoint f4f14458 TOTAL NOW=3 CALL_LIST=1
13:31:30 257874984mS CMMap: PCGP g P[227] originCP_mp pcp[74]b1r0
13:31:30 257874984mS CMTARGET: CMPagingEndpoint 0.1603.0 173 PagingEP 299 RequestEnd, 1 targets
13:31:30 257874984mS CMCallEvt: 252.1604.0 173 Paging Server.0: StateChange: END=child CMCSOffering->CMCSAccept
13:31:32 257876006mS SIP Rx: UDP 192.168.42.50:5060 -> 192.168.42.1:5060
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
Contact: <sip:299@192.168.42.50:5060>
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:31:32 257876008mS SIP Call Rx: phone
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
Contact: <sip:299@192.168.42.50:5060>
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:31:32 257876008mS CMExtnRx: v=299, p1=0
CMAlerting
Line: type=SIPLine 260 Call: lid=252 id=1604 in=0
13:31:32 257876009mS CMCallEvt: 252.1604.0 173 Paging Server.0: StateChange: END=child CMCSAccept->CMCSRinging
13:31:32 257876009mS CMExtnEvt: v=0 State, new=Ringing old=Idle,0,0,Paging Server
13:31:32 257876010mS SIP Rx: UDP 192.168.42.50:5060 -> 192.168.42.1:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
Contact: <sip:299@192.168.42.50:5060>
Content-Type: application/sdp
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 182
v=0
o=299 123456 654321 IN IP4 192.168.42.50
s=A conversation
c=IN IP4 192.168.42.50
t=0 0
m=audio 10500 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
13:31:32 257876012mS SIP Call Rx: phone
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK3691b25552eece2c01459bf7331006ae
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 INVITE
Contact: <sip:299@192.168.42.50:5060>
Content-Type: application/sdp
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 182
v=0
o=299 123456 654321 IN IP4 192.168.42.50
s=A conversation
c=IN IP4 192.168.42.50
t=0 0
m=audio 10500 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
13:31:32 257876014mS SIP Call Tx: phone
ACK sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK67bdebf6c7ebef1398a9ced6d37006ea
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 ACK
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
13:31:32 257876014mS SIP Tx: UDP 192.168.42.1:5060 -> 192.168.42.50:5060
ACK sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK67bdebf6c7ebef1398a9ced6d37006ea
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468535 ACK
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
13:31:32 257876015mS Sip: 252.1604.0 173 Paging Server.0(f4f1bc98) SetRfc2833TxPayload: use RFC2833 for dtmf
13:31:32 257876015mS Sip: 252.1604.0 173 Paging Server.0(f4f1bc98) SetRemoteRTPAddress to 192.168.42.50:10500
13:31:32 257876016mS CMExtnRx: v=299, p1=0
CMConnect
Line: type=SIPLine 260 Call: lid=252 id=1604 in=0
Called[Extn201] Type=Default (100) Reason=CMDRdirect
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEFastStartInfoData (6) 2 item(s)
13:31:32 257876016mS CMCallEvt: 252.1604.0 173 Paging Server.0: StateChange: END=child CMCSRinging->CMCSConnReq
13:31:32 257876016mS CMExtnEvt: v=0 State, new=Connected old=Ringing,0,0,Paging Server
13:31:32 257876016mS CMCallEvt: 252.1604.0 173 Paging Server.0: StateChange: END=child CMCSConnReq->CMCSConnected
13:31:32 257876019mS CMExtnTx: v=299, p1=0
CMConnectAck
Line: type=SIPLine 260 Call: lid=252 id=1604 in=0
Timed: 15/11/18 13:31
13:31:32 257876019mS CMExtnTx: v=299, p1=0
CMFacility
Line: type=SIPLine 260 Call: lid=252 id=1604 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 15/11/18 13:31
13:31:32 257876020mS CMCallEvt: 0.1603.0 173 PagingEP 299: StateChange: END=B CMCSOffering->CMCSConnReq
13:31:32 257876020mS CMCallEvt: 0.1601.0 173 Extn201.0: StateChange: END=A CMCSDialling->CMCSOGConnReq
13:31:32 257876020mS CMExtnEvt: v=1 State, new=Connected old=Dialling,0,0,Extn201
13:31:32 257876021mS CMExtnTx: v=201, p1=0
CMConnect
Line: type=DigitalExtn 2 Call: lid=0 id=1601 in=0
Called[Extn201] Type=Default (100) Reason=CMDRdirect
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Paging Server
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=299
IE CMIEDeviceDetail (231) LOCALE=enu HW=15 VER=9 class=CMDevicePagingConference type=0 number=0 channel=0 features=0x1 rx_gain=32 tx_gain=32 ep_callid=1603 ipaddr=192.168.42.1 apps=0 loc=0 em_loc=0 features2=0x0
Timed: 15/11/18 13:31
13:31:32 257876021mS CMExtnRx: v=201, p1=0
CMConnectAck
Line: type=DigitalExtn 2 Call: lid=0 id=1601 in=0
13:31:32 257876021mS CMCallEvt: 0.1601.0 173 Extn201.0: StateChange: END=A CMCSOGConnReq->CMCSConnected
13:31:32 257876021mS CMTARGET: 0.1601.0 173 Extn201.0: ~CMTargetHandler f4f0d798 ep f4f163c8
13:31:32 257876022mS CMCallEvt: 0.1603.0 173 PagingEP 299: StateChange: END=B CMCSConnReq->CMCSConnected
13:31:32 257876024mS H323Evt: SetOperational 203 192.168.42.1:0 to 0
13:31:32 257876025mS H323Evt: SetRfc2833 203: (1) rx payload 101 tx payload 101
13:31:32 257876025mS CMMap: PCG::AddToneGenerator g P[227] for cp[393]b0r1 append pcp[394]b0r1 (total 2)
13:31:32 257876025mS CMMap: PCGP g P[227] created ip generator pcp[394]b0r1 ConfigureGenerator origin is ip 0
13:31:32 257876026mS CD: CALL: 0.1601.0 BState=Connected Cut=3 Music=0.0 Aend="Extn201(201)" (0.1) Bend="Paging Server(299)" [Paging Server(299)] (0.0) CalledNum=299 (Paging Server) CallingNum=201 (Extn201) Internal=1 Time=2547 AState=Connected
13:31:33 257877021mS CMMap: a=21.11 b=0.0 DTMF::AllocateRAS allocated CMRTVoicemail resource busy 2, total 45
13:31:33 257877021mS CMMap: a=21.11 b=1.65535 T
13:31:33 257877021mS CMMap: PCG::MapBChan pcp[74]b1r0 cp_b f5233228 other_cp_b f5698438 type CGTypeDTMF
13:31:33 257877021mS CMMap: a=21.11 b=0.1 M22
13:31:33 257877021mS CMMap: PCG::MapBChan pcp[394]b0r1 cp_b f56a1228 other_cp_b f5698438 type CGTypeDTMF
13:31:33 257877021mS CMMap: a=21.11 b=0.18 M22
13:31:33 257877021mS CMMap: PlatformConnectionAudioSAP::Bind pcp[394]b0r1 to 0.18
13:31:33 257877022mS CMMap: PlatformConnectionAudioSAP::ConnectVoice (connect) pcp[394]b0r1 echo_cancellation set to 0
13:31:33 257877022mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[394]b0r1 Configure 0.18
13:31:33 257877022mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[394]b0r1 ConnectIndication 0.18
13:31:33 257877022mS CMMap: DTMF:
layTones g T[228] xE13:31:33 257877022mS CMMap: Started playing tones, P[227] (from g null)
13:31:33 257877022mS CMMap: P[227] SetOperGroup from g null to g null not executed, playing tones in progress xE
13:31:33 257877387mS CMMap: PCG::UnmapBChan pcp[394]b0r1 cp_b f56a1228 other_cp_b f5698438
13:31:33 257877387mS CMMap: a=21.11 b=0.18 M02
13:31:33 257877387mS CMMap: PCG::UnmapBChan pcp[74]b1r0 cp_b f5233228 other_cp_b f5698438
13:31:33 257877387mS CMMap: a=21.11 b=0.1 M02
13:31:33 257877388mS CMMap: PCG::UnmapBChan g P[227] cp_b 0 other_cp_b f5698438
13:31:33 257877388mS CMMap: a=21.11 b=0.0 T0
13:31:33 257877388mS CMMap: a=21.11 b=0.0 DTMF::~DTMF freed CMRTUnknown resource busy 1, total 45
13:31:33 257877389mS CMMap: PCGP g P[227] created ip generator pcp[394]b0r1 ConfigureGenerator origin is ip 0
13:31:33 257877389mS CMMap: PCGP g P[227] created ip generator pcp[394]b0r1 ConfigureGenerator origin is ip 0
13:31:33 257877389mS CMMap: PCGP g P[227] MapBChan cp_other pcp[74]b1r0 rtp_fwd_action ff src_fwd_action ff
13:31:33 257877389mS CMMap: a=0.1 b=0.18 M22
13:31:33 257877389mS CMMap: PCGP g P[227] created ip generator pcp[394]b0r1 ConfigureGenerator origin is ip 0
13:31:33 257877389mS CMMap: PCGP g P[227] MapBChan cp_other pcp[394]b0r1 rtp_fwd_action 8 src_fwd_action 2
13:31:33 257877389mS H323Evt: SetOperational 203 192.168.42.1:49152 to 1
13:31:33 257877390mS H323Evt: SetSendOnly 203 192.168.42.1:49152 to 1
13:31:34 257878147mS H323Evt: RTP(50t): 192.168.42.1/49152 192.168.42.50/10500 CODEC=Ulaw64K(5) PKTSZ=160 RFC2833=on AGE=2123 SENT=50 (avg size=160) RECV=0 (avg size=0)
13:31:37 257881228mS RES: Thu 15/11/2018 13:31:37 FreeMem=55230216 54519640(16) CachedMem=710576 CMMsg=8(9) Buff=5200 1358 1000 7443 5 Links=48149 BTree=14678 CPU=03.30% CPUStats=1/4/4357/18886/23147/0/0 MCR=0 MCW=0
13:31:37 257881228mS RES2: IP 500 V2 9.0.3.0 build 941 Tasks=50 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=62 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=18(TLS=2) TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
13:31:37 257881228mS RES4: XML MemObjs=61 PoolMem=2097152(1) FreeMem=2081872(1)
13:31:39 257883891mS CMExtnRx: v=201, p1=0
CMReleaseComp
Line: type=DigitalExtn 2 Call: lid=0 id=1601 in=0
13:31:39 257883891mS CMCallEvt: 0.1601.0 173 Extn201.0: StateChange: END=A CMCSConnected->CMCSCompleted
13:31:39 257883892mS CMExtnEvt: v=1 State, new=PortRecoverDelay old=Connected,0,0,Extn201
13:31:39 257883892mS CMLOGGING: CALL:2018/11/1513:31,00:00:07,000,201,O,299,*#299,Extn201,,,1,,""n/a,0
13:31:39 257883893mS CD: CALL: 0.1601.0 BState=Connected Cut=2 Music=0.0 Aend="EPaging Server(299)" (0.1) Bend="Paging Server(299)" [Paging Server(299)] (0.0) CalledNum=299 (Paging Server) CallingNum=201 (Extn201) Internal=1 Time=10414 AState=Idle
13:31:39 257883893mS CD: CALL: 0.1601.0 Deleted
13:31:39 257883893mS CMExtnEvt: Extn201: CALL LOST (CMCauseNormal)
13:31:39 257883893mS CMExtnEvt: Extn201: Extn(201) Calling Party Number(201) Type(CMNTypeInternal)
13:31:39 257883893mS CMExtnEvt: Extn201: CMExtnHandler::SetCurrent( id: 1601->0 )
13:31:39 257883893mS CMCallEvt: 0.1601.0 -1 Extn201.-1: StateChange: END=X CMCSCompleted->CMCSDelete
13:31:39 257883894mS CMExtnEvt: Paging Server: CALL LOST (CMCauseNormal)
13:31:39 257883894mS CMExtnEvt: Paging Server: Extn(299) Calling Party Number(201) Type(CMNTypeInternal)
13:31:39 257883894mS CMCallEvt: 252.1604.0 -1 Paging Server.0: StateChange: END=X CMCSConnected->CMCSCompleted
13:31:39 257883895mS CMExtnEvt: v=0 State, new=PortRecoverDelay old=Connected,0,0,Paging Server
13:31:39 257883895mS CMExtnTx: v=299, p1=0
CMReleaseComp
Line: type=SIPLine 260 Call: lid=252 id=1604 in=0
Called[299] Type=Paging (104) Reason=CMDRdirect Calling[201] Type=Internal Plan=Default
Cause=16, Normal call clearing
Timed: 15/11/18 13:31
13:31:39 257883897mS SIP Call Tx: phone
BYE sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bKf077231c12db02cb0e1250dbe77cf9d1
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468536 BYE
Contact: "Extn201" <sip:201@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Supported: timer,100rel
Reason: Q.850;cause=16;text="Normal call clearing"
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
13:31:39 257883897mS SIP Tx: UDP 192.168.42.1:5060 -> 192.168.42.50:5060
BYE sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bKf077231c12db02cb0e1250dbe77cf9d1
From: "Extn201" <sip:201@192.168.42.1>;tag=70acaad0005f33f6
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=264589211
Call-ID: fe356801eec1b0028f04ca513d7d6b50
CSeq: 1288468536 BYE
Contact: "Extn201" <sip:201@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Supported: timer,100rel
Reason: Q.850;cause=16;text="Normal call clearing"
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
[highlight #FCE94F]Trace from IP Phone ext 210 only owrks on Algo speakers not Cyberdata:[/highlight]
13:38:44 258307932mS CMTARGET: 254.1611.0 176 IP Phone.0: Setting Hard Timer 4000
13:38:44 258307932mS CMTARGET: 254.1611.0 176 IP Phone.0: LOOKUP CALL ROUTE: type=100 called_party=*#299 sub= calling=210 dir=out complete=0 ses=0
13:38:44 258307933mS CMTARGET: 254.1611.0 176 IP Phone.0: ADD TARGET (N): number=*#299 type=100 depth=1 nobar=1 setorig=1 ses=0
13:38:44 258307933mS CMTARGET: 254.1611.0 176 IP Phone.0: SYS SC: *#299 5 299 sc=type=DialPaging code=*#xxx, num=N callinfop->sending_complete=0 secondary_dialtone=
13:38:44 258307933mS CMTARGET: 254.1611.0 176 IP Phone.0: ADD TARGET (N): number=299 type=104 depth=2 nobar=1 setorig=1 ses=0
13:38:44 258307934mS CMTARGET: 254.1611.0 176 IP Phone.0: SET USER: Paging Server orig=1
13:38:44 258307934mS CMTARGET: 254.1611.0 176 IP Phone.0: ADD USER: Paging Server depth=2 disallow_cw=0 dnd=0 real_call=0 group_call=0 type(CMNTypePaging) incl(0x0) excpt(0x0), allow_redir(1) remote=00000000 simult 0 (0)
13:38:44 258307934mS CMCallEvt: 0.1613.0 -1 BaseEP: NEW CMEndpoint f4f0bac0 TOTAL NOW=3 CALL_LIST=1
13:38:44 258307934mS CMCallEvt: 0.1614.0 -1 BaseEP: NEW CMEndpoint f4eb2a70 TOTAL NOW=4 CALL_LIST=1
13:38:44 258307934mS CMCallEvt: 0.1614.0 -1 Paging Server.-1: NEW CMExtnEndpoint f4eb2a70, Name=Paging Server, Extn=299, Phys Extn=299
13:38:44 258307936mS CMTARGET: 252.1614.0 176 Paging Server.0: ADD PRIMARY
13:38:44 258307936mS CMTARGET: 254.1611.0 176 IP Phone.0: CancelTimer CMTCDelayedProcessing
13:38:44 258307936mS CMTARGET: 254.1611.0 176 IP Phone.0: INITIAL TARGETING SUCCEEDED
13:38:44 258307937mS CMTARGET: 254.1611.0 176 IP Phone.0: GetNoAnswerTimer:15
13:38:44 258307937mS CMCallEvt: 0.1612.0 176 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
13:38:44 258307938mS CMCallEvt: 0.1613.0 176 PagingEP 299: StateChange: END=T CMCSIdle->CMCSOffering
13:38:44 258307938mS CMCallEvt: 252.1614.0 176 Paging Server.0: StateChange: END=T CMCSIdle->CMCSOffering
13:38:44 258307939mS CMExtnEvt: Paging Server: CMExtnHandler::SetCurrent( id: 0->1614 )
13:38:44 258307939mS CMExtnTx: v=299, p1=0
CMSetup
Line: type=SIPLine 260 Call: lid=252 id=1614 in=0
Called[299] Type=Paging (104) Reason=CMDRdirect Calling[210] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
IE CMIESupplementaryService (3)
Network Facility Extension
sourceEntity: 0
destinationEntity: 0
Interpretation APDU
discardAnyUnrecognisedInvokePdu
CallingName.Invoke.CodePageISO8859-1
invokeId 14762
user 'IP Phone' presentation Allowed
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEMediaWaitForConnect (16) CMIEMediaWaitForConnect
IE CMIECallingPartyName (110)(Type=CMNameDefault) name=IP Phone
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=IP Phone
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=210
IE CMIEDeviceDetail (231) LOCALE=enu HW=15 VER=9 class=CMDeviceH323Phone type=39 number=8003 channel=0 features=0x10000420 rx_gain=32 tx_gain=32 ep_callid=1611 ipaddr=192.168.42.1 apps=0 loc=0 em_loc=0 features2=0x0
IE CMIEMohSourceId (247) MOH Source = 255
IE CMIESecurityData (253) 2 item(s)
Display [IP Phone>299]
Timed: 15/11/18 13:38
Locale: enu
13:38:44 258307939mS Sip: SIPDialog f4f1bc98 created, dialogs 1
13:38:44 258307941mS Sip: 252.1614.0 176 Paging Server.0(f4f1bc98) SetLocalRTPAddress to 192.168.42.1:49154
13:38:44 258307943mS SIP Call Tx: phone
INVITE sip:299@192.168.42.50;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
Contact: "IP Phone" <sip:210@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Content-Type: application/sdp
Supported: timer,100rel
User-Agent: IP Office 9.0.3.0 build 941
P-Asserted-Identity: "IP Phone" <sip:210@192.168.42.1:5060>
Content-Length: 202
Call-Info: <sip:192.168.42.1:5060>; answer-after=0
v=0
o=UserA 940663678 954463514 IN IP4 192.168.42.1
s=Session SDP
c=IN IP4 192.168.42.1
t=0 0
m=audio 49154 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
13:38:44 258307943mS SIP Tx: UDP 192.168.42.1:5060 -> 192.168.42.50:5060
INVITE sip:299@192.168.42.50;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
Contact: "IP Phone" <sip:210@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Content-Type: application/sdp
Supported: timer,100rel
User-Agent: IP Office 9.0.3.0 build 941
P-Asserted-Identity: "IP Phone" <sip:210@192.168.42.1:5060>
Content-Length: 202
Call-Info: <sip:192.168.42.1:5060>; answer-after=0
v=0
o=UserA 940663678 954463514 IN IP4 192.168.42.1
s=Session SDP
c=IN IP4 192.168.42.1
t=0 0
m=audio 49154 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-15
13:38:44 258307944mS CD: CALL: 254.1611.0 BState=Idle Cut=0 Music=0.0 Aend="IP Phone(210)" (0.0) Bend="Paging Server(299)" [Paging Server] (0.0) CalledNum=299 (Paging Server) CallingNum=210 (IP Phone) Internal=1 Time=2749 AState=Dialling
13:38:44 258307948mS SIP Rx: UDP 192.168.42.50:5060 -> 192.168.42.1:5060
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:38:44 258307949mS SIP Call Rx: phone
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:38:44 258307950mS CMExtnRx: v=299, p1=0
CMProceeding
Line: type=SIPLine 260 Call: lid=252 id=1614 in=0
13:38:44 258307950mS CMCallEvt: 0.1612.0 176 TargetingEP: RequestEnd 0.1613.0 176 PagingEP 299
13:38:44 258307950mS CMTARGET: 254.1611.0 176 IP Phone.0: CancelTimer CMTCNoAnswerTimeout
13:38:44 258307950mS CMCallEvt: 0.1612.0 -1 BaseEP: DELETE CMEndpoint f4f14458 TOTAL NOW=3 CALL_LIST=1
13:38:44 258307951mS CMMap: PCGP g P[231] originCP_mp pcp[401]b0r1
13:38:44 258307951mS CMTARGET: CMPagingEndpoint 0.1613.0 176 PagingEP 299 RequestEnd, 1 targets
13:38:44 258307951mS CMCallEvt: 252.1614.0 176 Paging Server.0: StateChange: END=child CMCSOffering->CMCSAccept
13:38:45 258308967mS SIP Rx: UDP 192.168.42.50:5060 -> 192.168.42.1:5060
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
Contact: <sip:299@192.168.42.50:5060>
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:38:45 258308969mS SIP Call Rx: phone
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
Contact: <sip:299@192.168.42.50:5060>
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 0
13:38:45 258308970mS CMExtnRx: v=299, p1=0
CMAlerting
Line: type=SIPLine 260 Call: lid=252 id=1614 in=0
13:38:45 258308970mS CMCallEvt: 252.1614.0 176 Paging Server.0: StateChange: END=child CMCSAccept->CMCSRinging
13:38:45 258308970mS CMExtnEvt: v=0 State, new=Ringing old=Idle,0,0,Paging Server
13:38:45 258308971mS SIP Rx: UDP 192.168.42.50:5060 -> 192.168.42.1:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
Contact: <sip:299@192.168.42.50:5060>
Content-Type: application/sdp
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 182
v=0
o=299 123456 654321 IN IP4 192.168.42.50
s=A conversation
c=IN IP4 192.168.42.50
t=0 0
m=audio 10500 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
13:38:45 258308974mS SIP Call Rx: phone
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.42.1:5060;rport=5060;branch=z9hG4bK39f644d44629bbfe35b39c7313723e2c
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 INVITE
Contact: <sip:299@192.168.42.50:5060>
Content-Type: application/sdp
User-Agent: Cyberdata Paging Server v7.2.0
Content-Length: 182
v=0
o=299 123456 654321 IN IP4 192.168.42.50
s=A conversation
c=IN IP4 192.168.42.50
t=0 0
m=audio 10500 RTP/AVP 0 101
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
13:38:45 258308976mS SIP Call Tx: phone
ACK sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK2b44526c104c2cf1c8bae1a2b0151b91
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 ACK
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
13:38:45 258308976mS SIP Tx: UDP 192.168.42.1:5060 -> 192.168.42.50:5060
ACK sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK2b44526c104c2cf1c8bae1a2b0151b91
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985056 ACK
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
13:38:45 258308976mS Sip: 252.1614.0 176 Paging Server.0(f4f1bc98) SetRfc2833TxPayload: use RFC2833 for dtmf
13:38:45 258308977mS Sip: 252.1614.0 176 Paging Server.0(f4f1bc98) SetRemoteRTPAddress to 192.168.42.50:10500
13:38:45 258308977mS CMExtnRx: v=299, p1=0
CMConnect
Line: type=SIPLine 260 Call: lid=252 id=1614 in=0
Called[IP Phone] Type=Default (100) Reason=CMDRdirect
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEFastStartInfoData (6) 2 item(s)
13:38:45 258308977mS CMCallEvt: 252.1614.0 176 Paging Server.0: StateChange: END=child CMCSRinging->CMCSConnReq
13:38:45 258308977mS CMExtnEvt: v=0 State, new=Connected old=Ringing,0,0,Paging Server
13:38:45 258308978mS CMCallEvt: 252.1614.0 176 Paging Server.0: StateChange: END=child CMCSConnReq->CMCSConnected
13:38:45 258308981mS CMExtnTx: v=299, p1=0
CMConnectAck
Line: type=SIPLine 260 Call: lid=252 id=1614 in=0
Timed: 15/11/18 13:38
13:38:45 258308981mS CMExtnTx: v=299, p1=0
CMFacility
Line: type=SIPLine 260 Call: lid=252 id=1614 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 15/11/18 13:38
13:38:45 258308982mS CMCallEvt: 0.1613.0 176 PagingEP 299: StateChange: END=B CMCSOffering->CMCSConnReq
13:38:45 258308982mS CMCallEvt: 254.1611.0 176 IP Phone.0: StateChange: END=A CMCSDialling->CMCSOGConnReq
13:38:45 258308982mS CMExtnEvt: v=5 State, new=Connected old=Dialling,0,0,IP Phone
13:38:45 258308983mS CMExtnTx: v=210, p1=0
CMConnect
Line: type=IPLine 250 Call: lid=254 id=1611 in=0
Called[IP Phone] Type=Default (100) Reason=CMDRdirect
IE CMIERespondingPartyName (228)(Type=CMNameDefault) name=Paging Server
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=299
IE CMIEDeviceDetail (231) LOCALE=enu HW=15 VER=9 class=CMDevicePagingConference type=0 number=0 channel=0 features=0x1 rx_gain=32 tx_gain=32 ep_callid=1613 ipaddr=192.168.42.1 apps=0 loc=0 em_loc=0 features2=0x0
Timed: 15/11/18 13:38
13:38:45 258308983mS CMExtnRx: v=210, p1=0
CMConnectAck
Line: type=IPLine 250 Call: lid=254 id=1611 in=0
13:38:45 258308983mS CMCallEvt: 254.1611.0 176 IP Phone.0: StateChange: END=A CMCSOGConnReq->CMCSConnected
13:38:45 258308984mS CMTARGET: 254.1611.0 176 IP Phone.0: ~CMTargetHandler f4f0d798 ep f4f163c8
13:38:45 258308985mS CMCallEvt: 0.1613.0 176 PagingEP 299: StateChange: END=B CMCSConnReq->CMCSConnected
13:38:45 258308989mS H323Evt: SetOperational 208 192.168.42.1:0 to 0
13:38:45 258308989mS H323Evt: SetRfc2833 208: (1) rx payload 101 tx payload 101
13:38:46 258309982mS CD: CALL: 254.1611.0 BState=Connected Cut=3 Music=0.0 Aend="IP Phone(210)" (0.0) Bend="Paging Server(299)" [Paging Server(299)] (0.0) CalledNum=299 (Paging Server) CallingNum=210 (IP Phone) Internal=1 Time=4788 AState=Connected
13:38:46 258309983mS CMMap: a=21.11 b=0.0 DTMF::AllocateRAS allocated CMRTVoicemail resource busy 2, total 45
13:38:46 258309983mS CMMap: a=21.11 b=1.65535 T
13:38:46 258309983mS CMMap: PCG::AddToneGenerator g T[232] for cp[401]b0r1 append pcp[404]b0r1 (total 1)
13:38:46 258309983mS CMMap: a=0.18 b=0.0 IP::ReserveCodec pcp[404]b0r1 allocated CMRTVocoder resource busy 1, total 10, codec type 5
13:38:46 258309983mS CMMap: a=21.11 b=0.18 M22
13:38:46 258309984mS CMMap: PlatformConnectionAudioSAP::Bind pcp[404]b0r1 to 0.18
13:38:46 258309984mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[404]b0r1 Configure 0.18
13:38:46 258309984mS CMMap: PlatformConnectionAudioSAP::ConnectVoice pcp[404]b0r1 ConnectIndication 0.18
13:38:46 258309984mS CMMap: PCG::MapBChan pcp[401]b0r1 cp_b 0 other_cp_b 0 type CGTypeDTMF
13:38:46 258309984mS H323Evt: SetOperational 207 192.168.42.1:49152 to 1
13:38:46 258309985mS H323Evt: SetOperational 208 192.168.42.1:49154 to 1
13:38:46 258309985mS H323Evt: SetSendOnly 208 192.168.42.1:49154 to 1
13:38:46 258309985mS CMMap: DTMF:
layTones g T[232] xE13:38:46 258309985mS CMMap: Started playing tones, P[231] (from g null)
13:38:46 258309985mS CMMap: P[231] SetOperGroup from g null to g null not executed, playing tones in progress xE
13:38:47 258310350mS H323Evt: SetOperational 208 192.168.42.1:49154 to 0
13:38:47 258310350mS H323Evt: SetSendOnly 208 192.168.42.1:49154 to 0
13:38:47 258310350mS H323Evt: SetOperational 207 192.168.42.1:49152 to 0
13:38:47 258310350mS CMMap: PCG::UnmapBChan pcp[404]b0r1 cp_b f56a1228 other_cp_b f5698438
13:38:47 258310350mS CMMap: a=21.11 b=0.18 M02
13:38:47 258310351mS CMMap: PCG::UnmapBChan g P[231] cp_b 0 other_cp_b f5698438
13:38:47 258310351mS CMMap: a=21.11 b=0.0 T0
13:38:47 258310351mS CMMap: a=21.11 b=0.0 DTMF::~DTMF freed CMRTUnknown resource busy 1, total 45
13:38:47 258310352mS CMMap: PCGP g P[231] MapBChan cp_other pcp[401]b0r1 rtp_fwd_action 3 src_fwd_action 8
13:38:47 258310352mS H323Evt: SetOperational 208 192.168.42.1:49154 to 1
13:38:47 258310352mS H323Evt: SetSendOnly 208 192.168.42.1:49154 to 1
13:38:47 258310352mS H323Evt: SetOperational 207 192.168.42.1:49152 to 1
13:38:47 258310353mS CMMap: a=0.18 b=0.0 IP::FreeCodec pcp[404]b0r1 freed CMRTVocoder resource busy 1, total 10
13:38:47 258310646mS RES: Thu 15/11/2018 13:38:47 FreeMem=55185912 54486832(15) CachedMem=699080 CMMsg=8(9) Buff=5200 1358 1000 7444 5 Links=48185 BTree=14678 CPU=05.84% CPUStats=3/7/4357/18061/23147/0/0 MCR=0 MCW=0
13:38:47 258310647mS RES2: IP 500 V2 9.0.3.0 build 941 Tasks=50 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=64 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=0 TCP=18(TLS=2) TAPI=0 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
13:38:47 258310647mS RES4: XML MemObjs=61 PoolMem=2097152(1) FreeMem=2081872(1)
13:38:48 258311173mS H323Evt: RTP(50t): 192.168.42.1/49154 192.168.42.50/10500 CODEC=Ulaw64K(5) PKTSZ=160 RFC2833=on AGE=2184 SENT=50 (avg size=163) RECV=0 (avg size=0)
13:38:49 258312672mS SIP Rx: UDP 192.168.42.50:5060 -> 192.168.42.1:5060
REGISTER sip:192.168.42.1 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.50:5060;rport;branch=z9hG4bK934463200
From: <sip:299@192.168.42.1>;tag=3932896046
To: <sip:299@192.168.42.1>
Call-ID: 1617665463
CSeq: 985 REGISTER
Contact: <sip:299@192.168.42.50:5060;line=48b17be0e0b4468>
Authorization: Digest username="299", realm="ipoffice", nonce="c407cf091fe59fdcfd32", uri="sip:192.168.42.1", response="ab0910e8c53d473b2138c1d1ac4258ff", algorithm=MD5
Max-Forwards: 70
User-Agent: Cyberdata Paging Server v7.2.0
Expires: 180
Content-Length: 0
13:38:49 258312674mS SIP Reg/Opt Rx: phone
REGISTER sip:192.168.42.1 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.50:5060;rport;branch=z9hG4bK934463200
From: <sip:299@192.168.42.1>;tag=3932896046
To: <sip:299@192.168.42.1>
Call-ID: 1617665463
CSeq: 985 REGISTER
Contact: <sip:299@192.168.42.50:5060;line=48b17be0e0b4468>
Authorization: Digest username="299", realm="ipoffice", nonce="c407cf091fe59fdcfd32", uri="sip:192.168.42.1", response="ab0910e8c53d473b2138c1d1ac4258ff", algorithm=MD5
Max-Forwards: 70
User-Agent: Cyberdata Paging Server v7.2.0
Expires: 180
Content-Length: 0
13:38:49 258312675mS Sip: SIPDialog f4f4ba50 created, dialogs 2
13:38:49 258312676mS SIP Reg/Opt Tx: phone
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.42.50:5060;rport;branch=z9hG4bK934463200
From: <sip:299@192.168.42.1>;tag=3932896046
Call-ID: 1617665463
CSeq: 985 REGISTER
User-Agent: IP Office 9.0.3.0 build 941
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:299@192.168.42.50:5060;line=48b17be0e0b4468>
Date: Thu, 15 Nov 2018 20:38:49 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.3.0 build 941
To: <sip:299@192.168.42.1>;tag=6747b3824b43889a
Content-Length: 0
13:38:49 258312677mS SIP Tx: UDP 192.168.42.1:5060 -> 192.168.42.50:5060
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.42.50:5060;rport;branch=z9hG4bK934463200
From: <sip:299@192.168.42.1>;tag=3932896046
Call-ID: 1617665463
CSeq: 985 REGISTER
User-Agent: IP Office 9.0.3.0 build 941
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,REFER,NOTIFY,INFO,SUBSCRIBE,REGISTER,PUBLISH
Contact: <sip:299@192.168.42.50:5060;line=48b17be0e0b4468>
Date: Thu, 15 Nov 2018 20:38:49 GMT
Expires: 180
Supported: timer
Server: IP Office 9.0.3.0 build 941
To: <sip:299@192.168.42.1>;tag=6747b3824b43889a
Content-Length: 0
13:38:49 258312677mS Sip: SIPDialog f4f4ba50 deleted, dialogs 1
********** SysMonitor v9.0.3.0 build 941 [connected to 192.168.42.1 (Default IP Page)] **********
13:38:50 258314572mS PRN: Monitor Status IP 500 V2 9.0.3.0 build 941
13:38:50 258314572mS PRN: LAW=U PRI=0, BRI=0, ALOG=4, VCOMP=10, MDM=0, WAN=0, MODU=0 LANM=0 CkSRC=0 VMAIL=1(VER=2 TYP=3) 1-X=0 CALLS=1(TOT=176)
13:38:52 258316826mS CMExtnTx: v=210, p1=8003
CMFacility
Line: type=IPLine 250 Call: lid=254 id=5 in=1
IE CMIEFastStartInfoData (6) 2 item(s)
13:38:52 258316826mS CMExtnRx: v=210, p1=0
CMReleaseComp
Line: type=IPLine 250 Call: lid=254 id=1611 in=0
13:38:52 258316826mS CMCallEvt: 254.1611.0 176 IP Phone.0: StateChange: END=A CMCSConnected->CMCSCompleted
13:38:52 258316827mS CMExtnEvt: v=5 State, new=PortRecoverDelay old=Connected,0,0,IP Phone
13:38:52 258316829mS CMExtnTx: v=210, p1=0
CMFacility
Line: type=IPLine 250 Call: lid=254 id=1611 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
Timed: 15/11/18 13:38
13:38:52 258316829mS CMLOGGING: CALL:2018/11/1513:38,00:00:07,000,210,O,299,*#299,IPPhone,,,1,,""n/a,0
13:38:52 258316830mS CD: CALL: 254.1611.0 BState=Connected Cut=2 Music=0.0 Aend="IPaging Server(299)" (0.0) Bend="Paging Server(299)" [Paging Server(299)] (0.0) CalledNum=299 (Paging Server) CallingNum=210 (IP Phone) Internal=1 Time=11635 AState=Idle
13:38:52 258316830mS CD: CALL: 254.1611.0 Deleted
13:38:52 258316831mS CMExtnEvt: IP Phone: CALL LOST (CMCauseNormal)
13:38:52 258316831mS CMExtnEvt: IP Phone: Extn(210) Calling Party Number(210) Type(CMNTypeInternal)
13:38:52 258316831mS CMExtnEvt: IP Phone: CMExtnHandler::SetCurrent( id: 1611->0 )
13:38:52 258316832mS CMCallEvt: 254.1611.0 -1 IP Phone.-1: StateChange: END=X CMCSCompleted->CMCSDelete
13:38:52 258316832mS CMExtnEvt: Paging Server: CALL LOST (CMCauseNormal)
13:38:52 258316833mS CMExtnEvt: Paging Server: Extn(299) Calling Party Number(210) Type(CMNTypeInternal)
13:38:52 258316833mS CMCallEvt: 252.1614.0 -1 Paging Server.0: StateChange: END=X CMCSConnected->CMCSCompleted
13:38:52 258316833mS CMExtnEvt: v=0 State, new=PortRecoverDelay old=Connected,0,0,Paging Server
13:38:52 258316834mS CMExtnTx: v=299, p1=0
CMReleaseComp
Line: type=SIPLine 260 Call: lid=252 id=1614 in=0
Called[299] Type=Paging (104) Reason=CMDRdirect Calling[210] Type=Internal Plan=Default
Cause=16, Normal call clearing
Timed: 15/11/18 13:38
13:38:52 258316835mS SIP Call Tx: phone
BYE sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK43dd2090697f51e8875006066c54cca8
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985057 BYE
Contact: "IP Phone" <sip:210@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Supported: timer,100rel
Reason: Q.850;cause=16;text="Normal call clearing"
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
13:38:52 258316835mS SIP Tx: UDP 192.168.42.1:5060 -> 192.168.42.50:5060
BYE sip:299@192.168.42.50:5060;line=48b17be0e0b4468 SIP/2.0
Via: SIP/2.0/UDP 192.168.42.1:5060;rport;branch=z9hG4bK43dd2090697f51e8875006066c54cca8
From: "IP Phone" <sip:210@192.168.42.1>;tag=934225e06ab11fee
To: <sip:299@192.168.42.1;line=48b17be0e0b4468>;tag=3448596611
Call-ID: 64d00e54827c25cadcf7602a917fe69f
CSeq: 1400985057 BYE
Contact: "IP Phone" <sip:210@192.168.42.1:5060;transport=udp>
Max-Forwards: 70
Allow: INVITE,ACK,CANCEL,OPTIONS,BYE,INFO,NOTIFY,SUBSCRIBE,REGISTER,PUBLISH,UPDATE
Supported: timer,100rel
Reason: Q.850;cause=16;text="Normal call clearing"
User-Agent: IP Office 9.0.3.0 build 941
Content-Length: 0
- Status