Call rings once then nothing

Collapse
X
Collapse
 
  • Page of 1
  • Filter
  • Time
  • Show
Clear All
new posts
Previous template Next
  • rfreil
    Hot Shot
    • Nov 2016
    • 16
    #1

    Call rings once then nothing

    Outside call comes in rings once the seems to drop.

    This happens sporadically but often enough to be a nuance.
    Below is the Sys Log showing the time and number when it happened.

    IP 500 V2 9.0.7.0 build 983




    IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLPrivateNetLocalUser (1), pd=CMPDInbandPattern (8)
    IE CMIERespondingPartyNumber (230)(P:100 S:100 T:0 N:100 R:4) number=815633829673
    IE CMIEDeviceDetail (231) LOCALE=enu HW=15 VER=9 class=CMDeviceISDNTrunk type=2 number=5 channel=20 features=0x0 rx_gain=32 tx_gain=32 ep_callid=25685 ipaddr=10.1.50.10 apps=8 loc=0 em_loc=0 features2=0x0
    Timed: 01/12/16 14:18
    14:18:06 508697419mS CD: CALL: 283.25683.0 BState=Ringing Cut=3 Music=0.0 Aend="bhageman(227)" (0.0) Bend="Line 5" [Line 5] (3.21) CalledNum=15633829673 () CallingNum=227 (bhageman) Internal=0 Time=11535 AState=Ringing
    14:18:06 508697420mS CMMap: a=3.21 b=0.0 PCGS CPReserveCodec (pcp[216]b0r1) true
    14:18:06 508697421mS CMMap: a=3.21 b=0.0 PCGS CPReserveCodec (pcp[216]b0r1) true
    14:18:06 508697421mS CMMap: PCG::MapBChan pcp[216]b0r1 cp_b f5413b48 other_cp_b f53c1580 type CGTypeSimple
    14:18:06 508697421mS CMMap: a=3.21 b=0.2 M12
    14:18:06 508697839mS RES: Thu 1/12/2016 14:18:06 FreeMem=46350328 44079144(2) CachedMem=2271184 CMMsg=13(13) Buff=5200 1356 1000 7409 5 Links=25503 BTree=12859 CPU=09.33% CPUStats=4/11/920/17078/22765/1/0 MCR=0 MCW=0
    14:18:06 508697839mS RES2: IP 500 V2 9.0.7.0 build 983 Tasks=54 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=160 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=1 TCP=182(TLS=5) TAPI=2 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
    14:18:06 508697839mS RES4: XML MemObjs=61 PoolMem=2097152(1) FreeMem=2081872(1)
    14:18:10 508701049mS CMExtnEvt: Hospitality200: No user activity
    14:18:10 508701235mS H323Evt: Recv: RegistrationRequest 10.1.50.27; Endpoints registered: 81; Endpoints in registration: 0
    14:18:11 508702153mS H323Evt: Recv: RegistrationRequest 10.1.50.44; Endpoints registered: 81; Endpoints in registration: 0
    14:18:11 508702959mS CMTARGET: ISDN BChannel 1: in-service check = 1
    14:18:11 508702959mS ISDNL3Evt: v=5 stacknum=5 State, new=Present, old=NullState id=15
    14:18:11 508702960mS CMLineRx: v=5
    CMSetup
    Line: type=Q931Line 5 Call: lid=5 id=15 in=1
    Called[9673] Type=Unknown (0) Reason=CMDRdirect SndComp Calling[815633875230] Type=Unknown Plan=ISDN Pres=Allowed (0)
    BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
    BChan: slot=0 chan=1
    14:18:11 508702961mS PRN: Q931Trunk: Found QBChannel to match 0.1 --> 3.2
    14:18:11 508702961mS CMCallEvt: 0.25686.0 -1 BaseEP: NEW CMEndpoint f466e2d8 TOTAL NOW=13 CALL_LIST=6
    14:18:11 508702961mS CMTARGET: ISDN BChannel 1: in-service check = 1
    14:18:11 508702962mS CMTARGET: ISDN BChannel 1: in-service check = 1
    14:18:11 508702962mS CMCallEvt: CREATE CALL:6018 (f45fe810)
    14:18:11 508702962mS CMCallEvt: 0.25687.0 -1 BaseEP: NEW CMEndpoint f44ac850 TOTAL NOW=14 CALL_LIST=6
    14:18:11 508702965mS CD: CALL: 5.15.1 BState=Idle Cut=1 Music=0.0 Aend="Line 5" (3.2) Bend="" [] (0.0) CalledNum=9673 () CallingNum=815633875230 () Internal=0 Time=3 AState=Idle
    14:18:11 508702965mS CMCallEvt: 5.15.1 6018 Q931 Trunk:5 CHAN=1: StateChange: END=A CMCSIdle->CMCSDialInitiated
    14:18:11 508702965mS CMTARGET: 5.15.1 6018 Q931 Trunk:5 CHAN=1: LOOKUP CALL ROUTE: type=0 called_party=9673 sub= calling=815633875230 dir=in complete=1 ses=0
    14:18:11 508702965mS CMTARGET: 5.15.1 6018 Q931 Trunk:5 CHAN=1: SET BESTMATCH: length 0 vs -1 match= dest=HospitalityHG
    14:18:11 508702965mS CMCallEvt: Priority hike: call 6018 priority 0->1
    14:18:11 508702965mS CMTARGET: 5.15.1 6018 Q931 Trunk:5 CHAN=1: LOOKUP ICR: DDI= CGPN=815633875230 (Destination HospitalityHG ) => CDPN=HospitalityHG
    14:18:11 508702966mS CMTARGET: 5.15.1 6018 Q931 Trunk:5 CHAN=1: ADD TARGET (N): number=HospitalityHG type=0 depth=1 nobar=1 setorig=1 ses=0
    14:18:11 508702966mS CMTARGET: 5.15.1 6018 Q931 Trunk:5 CHAN=1: HG(HospitalityHG,700,10.1.50.10) Requires Routing To Master(1). IsLocalExecutive(1)
    14:18:11 508702966mS CMTARGET: 5.15.1 6018 Q931 Trunk:5 CHAN=1: HG call targeting occuring here
    14:18:11 508702966mS CMTARGET: 5.15.1 6018 Q931 Trunk:5 CHAN=1: PrimeForHGTarget: HospitalityHG setorig=1 recall=0 resetExtnVars 1
    14:18:11 508702966mS CMCallEvt: Priority hike: call 6018 priority 1->5
    14:18:11 508702966mS CMTARGET: 5.15.1 6018 Q931 Trunk:5 CHAN=1: AddHGTarget HospitalityHG (depth=1) allowq=1 type=CMNTypeUnknown
    14:18:11 508702967mS CMCallEvt: 0.25688.0 -1 BaseEP: NEW CMEndpoint f463c1d0 TOTAL NOW=15 CALL_LIST=7
    14:18:11 508702967mS CMTARGET: 5.15.1 6018 Q931 Trunk:5 CHAN=1: AddHGTargetRingGroup HospitalityHG starting at 1
    14:18:11 508702967mS CMTARGET: 5.15.1 6018 Q931 Trunk:5 CHAN=1: ADD USER: Hospitality201 depth=2 disallow_cw=0 dnd=0 real_call=1 group_call=1 type(CMNTypeUnknown) incl(0x0) excpt(0x3c), allow_redir(1) remote=00000000 simult 0 (0)
    14:18:11 508702968mS CMMap: a=0.18 b=0.0 Mapper::AllocateCodec allocated CMRTVocoder(f5410838) resource busy 6, total 64
    14:18:11 508702968mS CMCallEvt: 0.25689.0 -1 BaseEP: NEW CMEndpoint f45c4c10 TOTAL NOW=16 CALL_LIST=7
    14:18:11 508702968mS CMCallEvt: 0.25689.0 -1 Hospitality201.-1: NEW CMExtnEndpoint f45c4c10, Name=Hospitality201, Extn=201, Phys Extn=201
    14:18:11 508702970mS CMTARGET: 256.25689.0 6018 Hospitality201.0: ADD PRIMARY
    14:18:11 508702970mS CMTARGET: 5.15.1 6018 Q931 Trunk:5 CHAN=1: ADD USER: Hospitality200 depth=2 disallow_cw=0 dnd=0 real_call=1 group_call=1 type(CMNTypeUnknown) incl(0x0) excpt(0x3c), allow_redir(1) remote=00000000 simult 0 (0)
    14:18:11 508702970mS CMCallEvt: 0.25690.0 -1 BaseEP: NEW CMEndpoint f4589838 TOTAL NOW=17 CALL_LIST=7
    14:18:11 508702970mS CMCallEvt: 0.25690.0 -1 Hospitality200.-1: NEW CMExtnEndpoint f4589838, Name=Hospitality200, Extn=200, Phys Extn=200
    14:18:11 508702972mS CMTARGET: 313.25690.0 6018 Hospitality200.0: ADD PRIMARY
    14:18:11 508702972mS CMTARGET: FoundKnownSystemTargets ICR cache hit
    14:18:11 508702972mS CMTARGET: 5.15.1 6018 Q931 Trunk:5 CHAN=1: INITIAL TARGETING SUCCEEDED
    14:18:11 508702973mS CMTARGET: 5.15.1 6018 Q931 Trunk:5 CHAN=1: GetNoAnswerTimer:15
    14:18:11 508702973mS CMCallEvt: 5.15.1 6018 Q931 Trunk:5 CHAN=1: StateChange: END=A CMCSDialInitiated->CMCSDialled
    14:18:11 508702973mS CMLineTx: v=5
    CMProceeding
    Line: type=Q931Line 5 Call: lid=5 id=15 in=1
    BChan: slot=0 chan=1
    14:18:11 508702974mS CMCallEvt: 0.25687.0 6018 TargetingEP: StateChange: END=B CMCSIdle->CMCSOffering
    14:18:11 508702975mS CMCallEvt: 256.25689.0 6018 Hospitality201.0: StateChange: END=T CMCSIdle->CMCSOffering
    14:18:11 508702976mS CMExtnEvt: Hospitality201: CMExtnHandler::SetCurrent( id: 0->25689 )
    Tags: None
  • rfreil
    Hot Shot
    • Nov 2016
    • 16
    #2
    14:18:11 508702977mS CMExtnTx: v=201, p1=0
    CMSetup
    Line: type=IPLine 250 Call: lid=256 id=25689 in=0
    Called[201] Type=Unknown (0) Reason=CMDRdirect SndComp Calling[815633875230] Type=Unknown Plan=ISDN Pres=Allowed (0)
    BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
    IE CMIEFastStartInfoData (6) 8 item(s)
    IE CMIECallSignalChannelData (8) unknown
    IE CMIEMediaWaitForConnect (16) CMIEMediaWaitForConnect
    IE CMIECalledPartyName (224)(Type=CMNameDefault) name=HospitalityHG
    IE CMIERespondingPartyNumber (230)(P:0 S:0 T:0 N:1 R:4) number=815633875230
    IE CMIEDeviceDetail (231) LOCALE=enu HW=15 VER=9 class=CMDeviceISDNTrunk type=2 number=5 channel=1 features=0x20 rx_gain=32 tx_gain=32 ep_callid=15 ipaddr=10.1.50.10 apps=8 loc=0 em_loc=0 features2=0x0
    IE CMIERedirectingPartyName (232)(Type=CMNameDefault) name=HospitalityHG
    IE CMIERedirectingPartyNumber (234)(P:100 S:100 T:101 N:100 R:4) number=700
    IE CMIEOriginalCalledPartyName (236)(Type=CMNameDefault) name=HospitalityHG
    IE CMIEOriginalCalledPartyNumber (238)(P:100 S:100 T:101 N:100 R:4) number=700
    IE CMIEIcrPriorityDetail (239) Priority = 1
    IE CMIEDIDNumber (245)(P:100 S:100 T:0 N:0 R:4) number=9673
    IE CMIEMohSourceId (247) MOH Source = 1
    IE CMIESecurityData (253) 2 item(s)
    UUI type=User2User [700..] [0x37 0x30 0x30 0xff 0xff ]
    Display [815633875230>HospitalityHG]
    Timed: 01/12/16 14:18
    Locale: enu
    14:18:11 508702977mS CMExtnRx: v=201, p1=0
    CMAlerting
    Line: type=IPLine 250 Call: lid=256 id=25689 in=0
    14:18:11 508702977mS CMCallEvt: 256.25689.0 6018 Hospitality201.0: StateChange: END=T CMCSOffering->CMCSRinging
    14:18:11 508702977mS CMExtnEvt: v=1 State, new=Ringing old=Idle,0,0,Hospitality201
    14:18:11 508702978mS CMCallEvt: 0.25687.0 6018 TargetingEP: StateChange: END=B CMCSOffering->CMCSRinging
    14:18:11 508702978mS CMCallEvt: 5.15.1 6018 Q931 Trunk:5 CHAN=1: StateChange: END=A CMCSDialled->CMCSRingBack
    14:18:11 508702979mS CMLineTx: v=5
    CMAlerting
    Line: type=Q931Line 5 Call: lid=5 id=15 in=1
    BChan: slot=0 chan=1
    14:18:11 508702984mS CMCallEvt: 313.25690.0 6018 Hospitality200.0: StateChange: END=T CMCSIdle->CMCSOffering
    14:18:11 508702985mS CMExtnEvt: Hospitality200: CMExtnHandler::SetCurrent( id: 0->25690 )
    14:18:11 508702985mS CMExtnTx: v=200, p1=0
    CMSetup
    Line: type=IPLine 250 Call: lid=313 id=25690 in=0
    Called[200] Type=Unknown (0) Reason=CMDRdirect SndComp Calling[815633875230] Type=Unknown Plan=ISDN Pres=Allowed (0)
    BC: CMTC=3K1Audio CMTM=Circuit CMTR=64 CMST=Default CMU1=ULaw
    IE CMIEFastStartInfoData (6) 8 item(s)
    IE CMIECallSignalChannelData (8) unknown
    IE CMIEMediaWaitForConnect (16) CMIEMediaWaitForConnect
    IE CMIECalledPartyName (224)(Type=CMNameDefault) name=HospitalityHG
    IE CMIERespondingPartyNumber (230)(P:0 S:0 T:0 N:1 R:4) number=815633875230
    IE CMIEDeviceDetail (231) LOCALE=enu HW=15 VER=9 class=CMDeviceISDNTrunk type=2 number=5 channel=1 features=0x20 rx_gain=32 tx_gain=32 ep_callid=15 ipaddr=10.1.50.10 apps=8 loc=0 em_loc=0 features2=0x0
    IE CMIERedirectingPartyName (232)(Type=CMNameDefault) name=HospitalityHG
    IE CMIERedirectingPartyNumber (234)(P:100 S:100 T:101 N:100 R:4) number=700
    IE CMIEOriginalCalledPartyName (236)(Type=CMNameDefault) name=HospitalityHG
    IE CMIEOriginalCalledPartyNumber (238)(P:100 S:100 T:101 N:100 R:4) number=700
    IE CMIEIcrPriorityDetail (239) Priority = 1
    IE CMIEDIDNumber (245)(P:100 S:100 T:0 N:0 R:4) number=9673
    IE CMIEMohSourceId (247) MOH Source = 1
    IE CMIESecurityData (253) 2 item(s)
    UUI type=User2User [700..] [0x37 0x30 0x30 0xff 0xff ]
    Display [815633875230>HospitalityHG]
    Timed: 01/12/16 14:18
    Locale: enu
    14:18:11 508702986mS CMExtnRx: v=200, p1=0
    CMAlerting
    Line: type=IPLine 250 Call: lid=313 id=25690 in=0
    14:18:11 508702986mS CMCallEvt: 313.25690.0 6018 Hospitality200.0: StateChange: END=T CMCSOffering->CMCSRinging
    14:18:11 508702986mS CMExtnEvt: v=2 State, new=Ringing old=Idle,0,0,Hospitality200
    14:18:11 508702991mS CD: CALL: 5.15.1 BState=Ringing Cut=1 Music=2.0 Aend="Line 5" (3.2) Bend="HospitalityHG(700)" [Hospitality201(201),Hospitality200(200)] (0.0) CalledNum=700 (HospitalityHG) CallingNum=815633875230 () Internal=0 Time=29 AState=Ringing
    14:18:11 508702997mS CMMap: a=3.2 b=0.0 R1
    14:18:11 508702997mS ISDNL3Evt: v=5 stacknum=5 State, new=ICProceeding, old=Present id=15
    14:18:11 508702998mS ISDNL3Evt: v=5 stacknum=5 State, new=Received, old=ICProceeding id=15
    14:18:12 508703027mS ISDNL3Evt: v=5 stacknum=5 State, new=Delivered, old=Proceeding id=25685
    14:18:12 508703028mS CMLineRx: v=5
    CMAlerting
    Line: type=Q931Line 5 Call: lid=0 id=25685 in=0
    IE CMIEProgressIndicator (30) cs=CMCSITUT (0), loc=CMLUser (0), pd=CMPDInbandPattern (8)
    14:18:12 508703043mS CMExtnEvt: v=(null) State, new=Idle old=Idle,0,0,228: Feature Key Pressed 10CPLFeatureCallLog
    14:18:12 508703044mS CMCallEvt: DCPLFieldBasedDisplayScreen::SetLine - Invalid line number (255(line_num) >= 8(op_line_count)) or Null buffer (text=f07c9fe0)
    14:18:12 508703048mS PRN: Config Write Wake Up
    14:18:12 508703348mS RES: Thu 1/12/2016 14:18:11 FreeMem=46271288 44079144(2) CachedMem=2192144 CMMsg=13(13) Buff=5200 1355 999 7410 5 Links=25389 BTree=12854 CPU=07.62% CPUStats=1/4/920/17355/22765/1/0 MCR=0 MCW=0
    14:18:12 508703348mS RES2: IP 500 V2 9.0.7.0 build 983 Tasks=54 RTEngine=0 CMRTEngine=0 ExRTEngine=0 Timer=167 Poll=0 Ready=0 CMReady=0 CMQueue=0 VPNNQueue=0 Monitor=2 SSA=1 TCP=182(TLS=5) TAPI=2 ASC=1 SYS=MNTD OPT=UMNT SDSPD=2034
    14:18:12 508703348mS RES4: XML MemObjs=61 PoolMem=2097152(1) FreeMem=2081872(1)
    14:18:12 508703548mS PRN: Updates IO list size 1 updated list size 1
    14:18:12 508703548mS PRN: Sending Updates out to f47e1c50 started
    14:18:12 508703549mS PRN: Sending Updates out to f47e1c50 finished
    14:18:12 508703549mS PRN: Config Write Completed
    14:18:14 508705325mS CMExtnTx: v=227, p1=8032
    CMFacility

    Comment

    • morri234
      Hot Shot
      • Aug 2015
      • 21
      #3
      What model phone is this occurring on?
      It sounds like the behavior of a second call to that extension were it indeed rings the phone once then projects a silent appearance.
      Also, in the programming, has the ring time been limited to that particular extension?

      Comment

      Previous template Next
      Loading