some phone dont dial out

[phonetech2012]

Hi, we have a demo set up in our lab. It is connected to a pri and calls can come in and out. But only a few sets are able to dial out. I have j129,j169 and j179 sets. It seems that none of the j169 or j179 sets can dial out, but the j129 sets can. Any ideas?
I noticed that the server type on the j169 is IPO CCMS, the type on the j129 is IPO SIP. I can not find how to change this setting. All these sets supposedly got the same 46xxx file sent to it.
Thanks

 

[derfloh]

Do you habe more details? What does the J129 send and what do the other phones? Do a SysMon trace with default filter settings.

Need some help with IP Office?

https://www.fwilke.com/home

 

[budbyrd]

Kinda might be important to know what version of IPO. I don't have any sort of KB in front of me but the version may be a factor.

Dermis and feline can be divorced by manifold methods.*
*(Disclaimer for all advise given)--'Version Dependent'

 

[OldSchool70]

Rls 11.0.4

********** Warning: Logging to Screen Stopped **********

********** Warning: Logging to Screen Started **********
93486791mS VMPro Tx: v=192.168.42.5:4097 -> 192.168.42.200:50791 p1=0
0000 27 00 00 00 00 00 00 00 00 04 00 01 00 01 01 00 '...............
0010 00 00 00 00 00 00 01 .......
93486792mS VMPro Tx: v=192.168.42.5:4097 -> 192.168.42.200:50791 p1=0
0000 06 00 00 00 00 00 00 00 07 02 04 00 01 00 01 01 ................
0010 00 00 00 00 00 00 0e 00 00 00 00 00 00 00 00 00 ................
0020 00 00 00 00 00 00 49 50 4f 20 44 65 6d 6f 00 00 ......IPO Demo..
0030 65 6e 75 03 00 04 00 00 00 78 28 65 28 f2 00 00 enu......x(e(...
0040 00 19 00 00 00 00 01 01 00 00 00 00 00 00 00 00 ................
0050 00 00 00 01 02 00 00 00 00 00 00 01 02 00 00 07 ................
0060 d0 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
93486795mS VMPro Rx: v=192.168.42.200:50791 -> 192.168.42.5:4097 p1=0
0000 07 0b 00 28 00 02 00 07 05 ...(.....
93486796mS VMPro Rx: v=192.168.42.200:50791 -> 192.168.42.5:4097 p1=0
0000 64 00 00 00 00 00 00 00 00 31 39 32 2e 31 36 38 d........192.168
0010 2e 39 32 2e 32 35 00 .92.25.
93486798mS VMPro Rx: v=192.168.42.200:50791 -> 192.168.42.5:4097 p1=0
0000 07 0b 00 28 00 02 00 07 05 ...(.....

********** SysMonitor v11.0.4.0.0 build 74 [connected to 192.168.42.5 (IPO Demo)] **********
93493269mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,5593: Digit Key Pressed 9
93493270mS CMCallEvt: 0000000000000000 0.1489.0 -1 BaseEP: NEW CMEndpoint f16fd040 TOTAL NOW=1 CALL_LIST=0
93493270mS CMCallEvt: 0000000000000000 0.1489.0 -1 Jim O'Hara.-1: NEW CMExtnEndpoint f16fd040, Name=Jim O'Hara, Extn=5593, Phys Extn=5593
93493271mS CMCallEvt: CREATE CALL:148 (f175dfac)
93493271mS CMCallEvt: 0000000000000000 0.1490.0 -1 BaseEP: NEW CMEndpoint f175c44c TOTAL NOW=2 CALL_LIST=0
93493273mS CMExtnEvt: Jim O'Hara: CMExtnHandler::SetCurrent( id: 0->1489 )
93493274mS CMExtnRx: v=5593, p1=0
CMSetup
Line: type=SIPLine 260 Call: lid=256 id=1489 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[5593] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ULaw
IE CMIEFastStartInfoData (6) 6 item(s)
IE CMIECallingPartyName (110)(Type=CMNameInternalUser) name=Jim O'Hara
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 3 (misc oob 0 misc rfc2833 0 prio oob 1 prio rfc2833 1)
IE CMIECallingPartyKName (226)(Type=CMNameDefault) name=Jim O'Hara
93493274mS CMExtnRxC: v=5593
CMSetup
Line: type=SIPLine 260 Call: lid=256 id=1489 in=0
Called[] Type=Default (100) Reason=CMDRdirect Calling[5593] Type=Internal Plan=Default
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ULaw
IE CMIEFastStartInfoData (6) 6 item(s)
IE CMIECallingPartyName (110)(Type=CMNameInternalUser) name=Jim O'Hara
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 3 (misc oob 0 misc rfc2833 0 prio oob 1 prio rfc2833 1)
IE CMIECallingPartyKName (226)(Type=CMNameDefault) name=Jim O'Hara
IE CMIERespondingPartyName (228)(Type=CMNameInternalUser) name=Jim O'Hara
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Jim O'Hara
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=5593
IE CMIEDeviceDetail (231) c0a82a05000005d1 LOCALE=enu HW=15 VER=11 class=CMDeviceSIPPhone type=182 number=14 channel=0 features=0x10110400 rx_gain=32 tx_gain=32
ep_callid=1489 ipaddr=192.168.42.5 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x20 is_spcall=0 ignores_dtmf=0 avgsid=
93493275mS CMCallEvt: c0a82a05000005d1 256.1489.0 148 Jim O'Hara.0: StateChange: END=A CMCSIdle->CMCSDialInitiated
93493275mS CMExtnEvt: v=0 State, new=Dialling old=Idle,0,0,Jim O'Hara
93493275mS CMTARGET: c0a82a05000005d1 256.1489.0 148 Jim O'Hara.0: LOOKUP CALL ROUTE: GID=0 type=100 called_party= sub= calling=5593 calling_sub= dir=out complete=0 ses=0
93493275mS CMTARGET: c0a82a05000005d1 256.1489.0 148 Jim O'Hara.0: ADD TARGET (N): number= type=100 depth=1 nobar=1 setorig=1 ses=0
93493276mS CMCallEvt: c0a82a05000005d1 256.1489.0 148 Jim O'Hara.0: StateChange: END=A CMCSDialInitiated->CMCSDialling
93493279mS CMExtnTxC: v=5593
CMFacility
Line: type=NoLine 0 Call: lid=256 id=1489 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 21 (misc oob 0 misc rfc2833 1 prio oob 1 prio rfc2833 0)
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 3)
}
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 3)
}
93493279mS CMExtnTx: v=5593, p1=0
CMFacility
Line: type=SIPLine 260 Call: lid=256 id=1489 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 21 (misc oob 0 misc rfc2833 1 prio oob 1 prio rfc2833 0)
IE CMIESecurityData (253) 2 item(s)
CMSecurityElement RX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 3)
}
CMSecurityElement TX_ONLY {
CMSRTPCryptoCapability none
Codecs list (size 3)
}
Timed: 14/05/19 15:31
93493282mS CMExtnTxC: v=5593
CMSetupAck
Line: type=NoLine 0 Call: lid=256 id=1489 in=0
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 1 (misc oob 0 misc rfc2833 0 prio oob 1 prio rfc2833 0)
93493282mS CMExtnTx: v=5593, p1=0
CMSetupAck
Line: type=SIPLine 260 Call: lid=256 id=1489 in=0
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 1 (misc oob 0 misc rfc2833 0 prio oob 1 prio rfc2833 0)
Timed: 14/05/19 15:31
93493283mS CMExtnRx: v=5593, p1=0
CMInformation
Line: type=SIPLine 260 Call: lid=256 id=1489 in=0
Called[9] Type=Default (100) Reason=CMDRdirect Keypad[9]
93493283mS CMExtnRxC: v=5593
CMInformation
Line: type=SIPLine 260 Call: lid=256 id=1489 in=0
Called[9] Type=Default (100) Reason=CMDRdirect Keypad[9]
IE CMIERespondingPartyName (228)(Type=CMNameInternalUser) name=Jim O'Hara
IE CMIERespondingPartyKName (229)(Type=CMNameDefault) name=Jim O'Hara
IE CMIERespondingPartyNumber (230)(P:100 S:100 T:101 N:100 R:4) number=5593
IE CMIEDeviceDetail (231) c0a82a05000005d1 LOCALE=enu HW=15 VER=11 class=CMDeviceSIPPhone type=182 number=14 channel=0 features=0x10110420 rx_gain=32 tx_gain=32
ep_callid=1489 ipaddr=192.168.42.5 apps=0 loc=0 em_a_loc=0 em_d_loc=0 features2=0x20 is_spcall=0 ignores_dtmf=0 avgsid=
93493283mS CMTARGET: c0a82a05000005d1 256.1489.0 148 Jim O'Hara.0: Setting Hard Timer 4000
93493284mS CMTARGET: c0a82a05000005d1 256.1489.0 148 Jim O'Hara.0: LOOKUP CALL ROUTE: GID=0 type=100 called_party=9 sub= calling=5593 calling_sub= dir=out complete=0 ses=0
93493284mS CMTARGET: c0a82a05000005d1 256.1489.0 148 Jim O'Hara.0: ADD TARGET (N): number=9 type=100 depth=1 nobar=1 setorig=1 ses=0
93493284mS CMTARGET: c0a82a05000005d1 256.1489.0 148 Jim O'Hara.0: SYS SC: 9 2 sc=type=Dial code=9N, num=N callinfop->sending_complete=0 secondary_dialtone=
93493285mS CMARS: FindActiveARSByGroupID GroupID=7 - Not Found
93493285mS CMLRQ: FindActiveLRQByGroupID GroupID=7 - Not Found
93493285mS CMTARGET: Group Id: 7 has NOT been found in Line: 1
93493285mS CMCallEvt: 0000000000000000 0.1491.0 -1 BaseEP: NEW CMEndpoint f173f9d8 TOTAL NOW=3 CALL_LIST=1
93493286mS CMTARGET: ISDN BChannel 8: in-service check = 1
93493288mS CMTARGET: DIAL LINE: 148 GROUP = 7 SUCCESS = f173f9d8
93493288mS CMTARGET: c0a82a05000005d1 256.1489.0 148 Jim O'Hara.0: CancelTimer CMTCDelayedProcessing
93493288mS CMTARGET: c0a82a05000005d1 256.1489.0 148 Jim O'Hara.0: INITIAL TARGETING SUCCEEDED
93493288mS CMTARGET: c0a82a05000005d1 256.1489.0 148 Jim O'Hara.0: GetNoAnswerTimer:15
93493289mS CMCallEvt: 0000000000000000 0.1490.0 148 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
93493291mS CMCallEvt: c0a82a05000005d3 0.1491.0 148 Q931 Trunk:9 CHAN=8: StateChange: END=T CMCSIdle->CMCSOffering
93493291mS CMLineTx: v=9
CMSetup
Line: type=Q931Line 9 Call: lid=0 id=1491 in=0
BC: CMTC=Speech CMTM=CallIndSigCon CMTR=64 CMST=Default CMU1=ULaw
BChan: slot=0 chan=8
Timed: 14/05/19 15:31
Locale: enu
93493293mS CD: CALL: 256.1489.0 BState=Idle Cut=0 Music=0.0 Aend="Jim O'Hara(5593)" (0.0) Bend="Line 9" [Line 9] (0.0) CalledNum=9 () CallingNum=5593 (Jim O'Hara) Internal=0 Time=22 AState=Dialling
93493293mS CD2: CALL:S 256.1489.0,0.1490.0,7,0,0,0,0,0,Jim O'Hara(5593),,Line 9,0.0,0.0,100.100,,100.101,5593,,,100,,100,,0,16,0,0,0.0,,,,,,,0,22,0,0,0,0,enu,,0,,0,0,0,0,,148,,,,,,,,,,,,,,,,,,,,,,,,,,,,,,
93493305mS CMCallPkt: v=0
CMReleaseComp
Line: type=Q931Line 9 Call: lid=0 id=1491 in=0
BChan: slot=0 chan=8
Cause=96, Mandatory information element missing
93493305mS CMLineRx: v=9
CMReleaseComp
Line: type=Q931Line 9 Call: lid=0 id=1491 in=0
BChan: slot=0 chan=8
Cause=96, Mandatory information element missing
93493306mS CMCallEvt: 0000000000000000 0.1490.0 148 TargetingEP: RequestEnd c0a82a05000005d3 0.1491.0 148 Q931 Trunk:9 CHAN=8
93493306mS CMTARGET: c0a82a05000005d1 256.1489.0 148 Jim O'Hara.0: CancelTimer CMTCNoAnswerTimeout
93493306mS CMCallEvt: 0000000000000000 0.1490.0 -1 BaseEP: DELETE CMEndpoint f175c44c TOTAL NOW=2 CALL_LIST=1
93493307mS CMCallEvt: c0a82a05000005d3 0.1491.0 148 Q931 Trunk:9 CHAN=8: StateChange: END=B CMCSOffering->CMCSCompleted
93493308mS CMExtnTxC: v=5593
CMFacility
Line: type=NoLine 0 Call: lid=256 id=1489 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 21 (misc oob 0 misc rfc2833 1 prio oob 1 prio rfc2833 0)
93493308mS CMExtnTx: v=5593, p1=0
CMFacility
Line: type=SIPLine 260 Call: lid=256 id=1489 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 21 (misc oob 0 misc rfc2833 1 prio oob 1 prio rfc2833 0)
Timed: 14/05/19 15:31
93493310mS CMLOGGING: CALL:2019/05/1415:31,00:00:00,000,5593,O,,9,JimO'Hara,,,0,,"",0,n/a
93493310mS CD: CALL: 256.1489.0 BState=Disconnecting Cut=0 Music=0.0 Aend="Jim O'Hara(5593)" (0.0) Bend="Line 9" [Line 9] (5.9) CalledNum= () CallingNum=5593 (Jim O'Hara) Internal=0 Time=39 AState=Dialling
93493311mS CD2: CALL:S 256.1489.0,0.1490.0,7,3,0,0,0,0,Jim O'Hara(5593),Line 9,,0.0,5.9,100.100,,100.101,5593,,,100,,100,,0,16,0,0,0.0,,,,,,,0,40,0,0,0,0,enu,,0,,0,0,0,0,,148,,,,,,,,,,,,,,,,0,0,Jim O'Hara,0,,3,0,0,0,0,0,0,1,618,100
93493311mS CD: CALL: 256.1489.0 Deleted
93493311mS CMExtnEvt: Jim O'Hara: CALL LOST (CMCauseMissingMandatoryIE)
93493312mS CMExtnEvt: Jim O'Hara: Extn(5593) Calling Party Number(5593) Type(CMNTypeInternal)
93493312mS CMCallEvt: c0a82a05000005d1 256.1489.0 -1 Jim O'Hara.0: StateChange: END=X CMCSDialling->CMCSCompletedTone
93493314mS CMExtnTxC: v=5593
CMFacility
Line: type=NoLine 0 Call: lid=256 id=1489 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 21 (misc oob 0 misc rfc2833 1 prio oob 1 prio rfc2833 0)
93493314mS CMExtnTx: v=5593, p1=0
CMFacility
Line: type=SIPLine 260 Call: lid=256 id=1489 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 21 (misc oob 0 misc rfc2833 1 prio oob 1 prio rfc2833 0)
Timed: 14/05/19 15:31
93493315mS CMExtnEvt: v=0 State, new=CMESCompleted old=Dialling,0,0,Jim O'Hara
93493316mS CMCallEvt: c0a82a05000005d3 0.1491.0 -1 Q931 Trunk:9 CHAN=8: StateChange: END=X CMCSCompleted->CMCSDelete
93493316mS CMCallEvt: END CALL:148 (f175dfac)
93493317mS CMTARGET: ISDN BChannel 8: in-service check = 1
93493317mS CD2: CALL 256.1489.0,0.1490.0,148,,,,,,,,,,,,,,,,0,0,Jim O'Hara,0,,3,0,0,0,0,0,0,1,618,100
93493317mS CMCallEvt: c0a82a05000005d3 0.1491.0 -1 BaseEP: DELETE CMEndpoint f173f9d8 TOTAL NOW=1 CALL_LIST=0
93496406mS CMExtnRx: v=5593, p1=0
CMReleaseComp
Line: type=SIPLine 260 Call: lid=256 id=1489 in=0
93496406mS CMCallEvt: c0a82a05000005d1 256.1489.0 -1 Jim O'Hara.0: StateChange: END=X CMCSCompletedTone->CMCSCompleted
93496407mS CMExtnTxC: v=5593
CMFacility
Line: type=NoLine 0 Call: lid=256 id=1489 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 21 (misc oob 0 misc rfc2833 1 prio oob 1 prio rfc2833 0)
93496408mS CMExtnTx: v=5593, p1=0
CMFacility
Line: type=SIPLine 260 Call: lid=256 id=1489 in=0
IE CMIEFastStartInfoData (6) 2 item(s)
IE CMIEDtmf (209) CMIEDtmf oob 1, txp 101, rxp 101, fmtp = <null>, misc 21 (misc oob 0 misc rfc2833 1 prio oob 1 prio rfc2833 0)
Timed: 14/05/19 15:31
93496408mS CMExtnEvt: v=0 State, new=PortRecoverDelay old=CMESCompleted,0,0,Jim O'Hara
93496408mS CMExtnEvt: Jim O'Hara: CALL LOST (CMCauseForceClear)
93496408mS CMExtnEvt: Jim O'Hara: Extn(5593) Calling Party Number(5593) Type(CMNTypeInternal)
93496409mS CMExtnEvt: Jim O'Hara: CMExtnHandler::SetCurrent( id: 1489->0 )
93496409mS CMCallEvt: c0a82a05000005d1 256.1489.0 -1 Jim O'Hara.-1: StateChange: END=X CMCSCompleted->CMCSDelete
93496412mS CMTARGET: c0a82a05000005d1 256.1489.0 -1 BaseEP: ~CMTargetHandler f17562b8 ep f16fd040
93496412mS CMCallEvt: c0a82a05000005d1 256.1489.0 -1 BaseEP: DELETE CMEndpoint f16fd040 TOTAL NOW=0 CALL_LIST=0
93496793mS VMPro Tx: v=192.168.42.5:4097 -> 192.168.42.200:50791 p1=0
0000 27 00 00 00 00 00 00 00 00 04 00 01 00 01 01 00 '...............
0010 00 00 00 00 00 00 01 .......
93496793mS VMPro Tx: v=192.168.42.5:4097 -> 192.168.42.200:50791 p1=0
0000 06 00 00 00 00 00 00 00 07 02 04 00 01 00 01 01 ................
0010 00 00 00 00 00 00 0e 00 00 00 00 00 00 00 00 00 ................
0020 00 00 00 00 00 00 49 50 4f 20 44 65 6d 6f 00 00 ......IPO Demo..
0030 65 6e 75 03 00 04 00 00 00 78 28 65 28 f2 00 00 enu......x(e(...
0040 00 19 00 00 00 00 01 01 00 00 00 00 00 00 00 00 ................
0050 00 00 00 01 02 00 00 00 00 00 00 01 02 00 00 07 ................
0060 d0 00 00 00 00 00 00 00 00 00 00 00 00 00 00 00 ................
93496796mS VMPro Rx: v=192.168.42.200:50791 -> 192.168.42.5:4097 p1=0
0000 07 0b 00 28 00 02 00 07 05 ...(.....
93496797mS VMPro Rx: v=192.168.42.200:50791 -> 192.168.42.5:4097 p1=0
0000 64 00 00 00 00 00 00 00 00 31 39 32 2e 31 36 38 d........192.168
0010 2e 39 32 2e 32 35 00 .92.25.
93496798mS VMPro Rx: v=192.168.42.200:50791 -> 192.168.42.5:4097 p1=0
0000 07 0b 00 28 00 02 00 07 05 ...(.....

********** Warning: Logging to Screen Stopped **********

 

[OldSchool70]

What I gather from this is that some Mandatory Information Element is missing but I do not know what information element is missing.

 

[derfloh]

SIP messages are missing... Looks like if the phone just dials 9 to IPO

Line 9] (0.0) CalledNum=9 () CallingNum=5593 (Jim O'Hara) Internal=0 Time=22 AState=Dialling

Need some help with IP Office?

https://www.fwilke.com/home