Guest TheyCalled Paul Report post Posted 04/23/2009 07:48 AM Hi, We had a new customer today. A call come into our platform and then we place a call and connect them. When we call his phone numbers, sometimes the calls go through and sometimes the calls just drop. We checked with the targets telco and they confirm that sometimes they will the call and others they do not. Our dialing technology has been stable for years so we are confused. If you search the log for 6022981390 you should be able to see the dropped calls. If we call his cell phone - its fine. I believe this sample is when the call drop in a split second I dont know how log space 164554.549 3620 67 rec2 hli_rec: chdev=69, linedev=67, networkdev=67, networkdev=67, voicedev=69 164554.549 3620 67 rec2 hli1: chdev=69, linedev=67, networkdev=67, networkdev=67, voicedev=69 164554.549 3620 67 rec2 hli2: chdev=6, linedev=4, networkdev=4, networkdev=4, voicedev=6 164554.549 3620 67 rec2 recording from two digital dti timeslots 164554.549 3620 67 rec2 dxxdev_rec=69, dtdev_1=67, dtdev_2=4 164554.549 3620 67 rec2 open save file call 164554.549 3620 rec2 open save file(strFname=d:\voice\18178_0422164554_6022981390.wav) => 5 164554.549 3620 rec2 rec silence detection disabled 164554.549 3620 rec2 rec max len limit on drv level disabled 164554.549 3620 rec2 rec stop on lcoff disabled (at dlgc driver level) 164554.549 3620 xpb xpb.wDataFormat=0x7 (1=adpcm, 3=alaw, 7=ulaw, 8=pcm) (usDataFormatRec=7), xpb.wFileFormat=2 (1=vox, 2=wav) 164554.549 3620 record2lines(69, ...) => 0, hli=220557104 164554.939 2292 4 CtEventProcess (from store) idx=569, evtdev=4, crn=0284003D, evttype=2086, data=06FB3968, len=28 (store: evinque=0, maxever=1) 164554.939 2292 4 ev GCEV_DISCONNECTED crn=0284003D=42205245 164554.939 2292 4 GCEV_DISCONNECTED : gcValue=68(0x44), gcMsg=[invalid parameter], ccLibId=2, ccLibName=[GC_ISDN_LIB], ccValue=0x38a, ccMsg=[bad input parameter], additionalInfo=[] 164554.939 2292 4 CTelProxy::Event_CallState GCEV_DISCONNECTED iLineCallState=16384, hCall=42205245 m_pktTelProxyClient=00671404 164554.939 2292 4 raise CallState GCEV_DISCONNECTED 164554.939 4584 4 fn DropCall(sLineId=4, sXMLOptions=[], iParam1=0) 164554.939 4584 4 TelDriver_DropCall(sXMLOptions=[]) Share this post Link to post
SupportTeam Report post Posted 04/23/2009 11:13 AM The ktTel trace shows that on the call at 16:45:54 after dialing the Dialogic card reported receiving the "Proceeding" ISDN message. The Proceeding message would have been sent by the Telco's Switch. Half a second later the Disconnect message is reported by the Dialogic card. You would really need to get the Telco to do an ISDN level trace on the line to confirm whether their switch is sending the Disconnect message, and if yes then the Telco should explain why their switch is sending that Disconnect message. 164554.220 4584 4 fn LineMakeCall(iLineId=4, iCallRequestId=0 (ignored), strNumberToCall=[16022981388], callprog=CONNECT_IMMEDIATELY, timeout=60, params:0,0,cid=[(null)],opt=[<calltype>DialAndConf</calltype>]) 164554.220 4584 4 makecall protocol is: ISDN 164554.220 4584 4 TelDriver_LineMakeCall hli->Dial_zsOtherCallProgressSettings=[<calltype>DialAndConf</calltype>] 164554.220 4584 4 Set_DX_CAP_ca_intflg zDial_DxCap.ca_intflg=DX_OPTDIS (CONNECT_IMMEDIATELY case) 164554.220 4584 4 CallProgressOption=[CONNECT_IMMEDIATELY] ca_intflg=56454828 164554.220 4584 MakeCall select driver. strDti=[dtiB1T2] 164554.220 4584 MakeCall driver non-HMP version used strDti=[dtiB1T2] 164554.220 4584 4 gc_MakeCall initialisation (SR) 164554.220 4584 4 set outgoing cid(4, []) ok 164554.220 4584 4 set outgoing CallerID name here. 164554.220 4584 4 makecall defsrc cc used. Non DM3 card 164554.220 4584 4 cc.BC_xfer_cap=BEAR_CAP_SPEECH 164554.220 4584 4 cc.BC_xfer_mode=ISDN_ITM_CIRCUIT 164554.220 4584 4 cc.BC_xfer_rate=BEAR_RATE_64KBPS 164554.220 4584 4 cc.usrinfo_layer1_protocol=ISDN_UIL1_G711ULAW 164554.220 4584 4 cc.usr_rate=ISDN_NOTUSED 164554.220 4584 4 cc.destination_number_type=NAT_NUMBER 164554.220 4584 4 cc.destination_number_plan=UNKNOWN_NUMB_PLAN 164554.220 4584 4 cc.destination_sub_number_type=OSI_SUB_ADDR 164554.220 4584 4 cc.origination_number_type=NAT_NUMBER 164554.220 4584 4 cc.origination_number_plan=UNKNOWN_NUMB_PLAN 164554.220 4584 4 cc.origination_sub_number_type/origination_sub_number_plan=OSI_SUB_ADDR/ISDN_NOTUSED 164554.220 4584 4 cc.facility_feature_service=ISDN_NOTUSED 164554.220 4584 4 cc.facility_coding_value=ISDN_NOTUSED 164554.220 4584 4 gc_MakeCall [16022981388] call (SR60) 164554.220 4584 4 gc_MakeCall ok. crn=0284003D 164554.220 4584 4 call progress detection not enabled as ca_intflg == DX_OPTDIS (2) 164554.220 4584 4 TelDriver_LineMakeCall returned 0, hli_Returned=035C4FA0 164554.220 4584 4 TelDriver_LineMakeCall returned hli_Returned->crn_lastMakeCall=0284003D 164554.220 4584 4 raise generic ktTel_Completion|10000 Completion_MakeCall|0 42205245 (42205245|0|0|16022981388|<calltype>DialAndConf</calltype>|<result>ok</result><crn>42205245</crn>) 164554.220 4584 4 LineMakeCall TelDriver_LineMakeCall zsResult=[<result>ok</result><crn>42205245</crn>] 164554.220 4584 67 fn PlayStop(iLineId=67, iActionID=0, iParam1=0, iParam1=0, sParam1=, sParam1=) 164554.220 4584 67 PlayStop(hLine=67, iPlayId=0(0x0), iParam1=0, iParam2=0, zsParam1=, zsParam2=) 164554.220 4584 67 dx_stopch call in PlayStop 164554.220 4584 67 dx_stopch 69 ok 164554.220 4584 4 fn PlayStop(iLineId=4, iActionID=0, iParam1=0, iParam1=0, sParam1=, sParam1=) 164554.220 4584 4 PlayStop(hLine=4, iPlayId=0(0x0), iParam1=0, iParam2=0, zsParam1=, zsParam2=) 164554.220 4584 4 dx_stopch call in PlayStop 164554.220 4584 4 dx_stopch 6 ok 164554.252 2292 4 CtEventProcess (from store) idx=567, evtdev=4, crn=0284003D, evttype=2145, data=0C30FC10, len=28 (store: evinque=0, maxever=1) 164554.252 2292 4 ev GCEV_DIALING crn=0284003D=42205245 crn_lastMakeCall=0284003D=42205245 164554.252 2292 4 CTelProxy::Event_CallState GCEV_DIALING iLineCallState=16, hCall=42205245 m_pktTelProxyClient=00671404 164554.252 2292 4 raise CallState GCEV_DIALING 164554.252 4584 fn TsRoute(sDev1Name=dtiB1T23, sDev1Type=, sDev2Name=dtiB1T2, sDev2Type=, sConnectionType=SC_FULLDUP 164554.252 4584 fn TsRoute [dtiB1T23][][dtiB1T2][][sC_FULLDUP], iDlgcBoardCount_DTI=2 164554.252 4584 set DevType1 = DTI, DevType2 = DTI 164554.252 4584 dt_open (dtiB1T23, 0) call 164554.252 4584 opened dt dtiB1T23 as devh=70 164554.252 4584 dt_open(dtiB1T2, 0) call 164554.267 4584 opened dt dtiB1T2 as devh=72 164554.267 4584 nr_scroute(70, 3, 72, 3, 0) call 164554.314 2292 4 CtEventProcess (from store) idx=568, evtdev=4, crn=0284003D, evttype=2087, data=0C30FD78, len=28 (store: evinque=0, maxever=1) 164554.314 2292 4 ev GCEV_PROCEEDING crn=0284003D=42205245 lastMakeCall=0x284003d (42205245) hli->crn=0284003D 164554.314 2292 4 ResultInfo gcValue=137(0x89) gcMsg=[CCLIB specific] ccLibId=2 ccLibName=[GC_ISDN_LIB] ccValue=[0x24|EGC_CCLIBSPECIFIC|cclib specific - a catchall] ccMsg=[Received PROCEEDING message] additionalinfo= ... 164554.939 2292 4 CtEventProcess (from store) idx=569, evtdev=4, crn=0284003D, evttype=2086, data=06FB3968, len=28 (store: evinque=0, maxever=1) 164554.939 2292 4 ev GCEV_DISCONNECTED crn=0284003D=42205245 164554.939 2292 4 GCEV_DISCONNECTED : gcValue=68(0x44), gcMsg=[invalid parameter], ccLibId=2, ccLibName=[GC_ISDN_LIB], ccValue=0x38a, ccMsg=[bad input parameter], additionalInfo=[] 164554.939 2292 4 CTelProxy::Event_CallState GCEV_DISCONNECTED iLineCallState=16384, hCall=42205245 m_pktTelProxyClient=00671404 164554.939 2292 4 raise CallState GCEV_DISCONNECTED 164554.939 4584 4 fn DropCall(sLineId=4, sXMLOptions=[], iParam1=0) 164554.939 4584 4 TelDriver_DropCall(sXMLOptions=[]) 164554.939 4584 4 clearing sDTMFsReceivedBeforeCallAnswer in TelDriver_DropCall 164554.939 4584 4 gc_DropCall crn=0284003D cause=16:GC_NORMAL_CLEARING (nocausetag) 164554.939 4584 4 gc_DropCall ok 164554.955 2292 4 CtEventProcess (from store) idx=570, evtdev=4, crn=0284003D, evttype=2053, data=0C30FAF8, len=28 (store: evinque=0, maxever=1) 164554.955 2292 4 ev GCEV_DROPCALL crn=0284003D 164554.955 2292 4 raise Dialogic GCEV_DROPCALL 2053 (2053 0 0 ) 164554.955 2292 4 CTelProxy::Event_CallState GCEV_DROPCALL iLineCallState=1, hCall=42205245 m_pktTelProxyClient=00671404 164554.955 2292 4 clearing sDTMFsReceivedBeforeCallAnswer [] in Event_CallState 164554.955 2292 4 raise CallState GCEV_DROPCALL Share this post Link to post