VoiceGuide IVR Software Main Page
Jump to content

Why It Thinks The Other Side Is Fax, How To Catch The Event

Recommended Posts

Hi,

 

We are using analog line, and the card is D4PCI-UF (D41JCT-LS). (voiceguid v6). Please take a look at the attached log segment. I don't know why it thinks the other side is fax. The phone rings and I pick up. But no expected messages, since the card thought it's a fax machine. We have two cards in the system and both have same problem. If we can't do anything to the phone signal, I am wondering if I can pick up the condition and do some program and the program can continue, otherwise it hang and the server seems dead.

 

Please help.

 

 

Ronghui

 

 

 

 

 

 

190428.52 2 state Waiting for a call...

190430.72 2 timer fired EV_TIMEOUT_AFTERIDLE_ALLOWOUT

190430.72 2 event EV_TIMEOUT_AFTERIDLE_ALLOWOUT, iCode=9013 state=900

190430.72 2 setting iDialoutReadyToDialout = 1

190440.25 2 dial [789,99338104,810291904,0,2359,MoTuWeThFrSaSu,[],1,c:\toa\callout\UGI_trial\1651152.wav,c:\toa\callout\UGI_trial\ugi_trial1.vgs,c:\toa\callout\UGI_trial\ugi_trial1.vgs,[PhoneNumberCalled]{99338104}[TOAID]{1260}[JOBID]{117}[First

Name]{Vincent}[LastName]{Yarmel}[Jobdesc]{Building Maint.}[FillCount]{2}[Token]{init}[CallBackPhone]{14089971698},29,0,5,c:\toa\callout\UGI_trial\ugi_notcon.vgs,] (search started at 190440.25)

190440.25 2 dial DialOnLine start tel[99338104] ann[c:\toa\callout\UGI_trial\1651152.wav] vgs[c:\toa\callout\UGI_trial\ugi_trial1.vgs] am[c:\toa\callout\UGI_trial\ugi_trial1.vgs] rv[[PhoneNumberCalled]{99338104}[TOAID]{1260}[JOBID]{117}[FirstName]{Vincent}[La

stName]{Yarmel}[Jobdesc]{Building Maint.}[FillCount]{2}[Token]{init}[CallBackPhone]{14089971698}] cid[]

190440.25 0 dial callque update id=789: NextCallTime=0810291909(10/29/2008 7:09:40 PM), RetriesLeft=-1

190440.25 2 rv clear all

190440.25 2 rv add [PhoneNumberCalled]{99338104}

190440.25 2 rv add [TOAID]{1260}

190440.25 2 rv add [JOBID]{117}

190440.25 2 rv add [FirstName]{Vincent}

190440.25 2 rv add [LastName]{Yarmel}

190440.25 2 rv add [Jobdesc]{Building Maint.}

190440.25 2 rv add [FillCount]{2}

190440.25 2 rv add [Token]{init}

190440.25 2 rv add [CallBackPhone]{14089971698}

190440.25 2 rv add [OutDial_ID]{789}

190440.25 2 rv add [OutDial_OnNotConnected]{c:\toa\callout\UGI_trial\ugi_notcon.vgs}

190440.25 2 rv add [OutDial_AnswerTimeout]{29}

190440.25 2 rv add [OutDial_RetriesLeft]{0}

190440.25 2 rv add [OutDial_PauseBetweenRetries]{5}

190440.25 2 dial making call tel[99338104] ann[c:\toa\callout\UGI_trial\1651152.wav] vgs[c:\toa\callout\UGI_trial\ugi_trial1.vgs] am[c:\toa\callout\UGI_trial\ugi_trial1.vgs] OnHangup[C:\toa\callout\UGI_trial\ugi_onfinish.vgs] rv[[PhoneNumberCalled]{99338104}[TOAID]{1260}[JOBID]{117}[FirstName]{Vincent}[La

stName]{Yarmel}[Jobdesc]{Building Maint.}[FillCount]{2}[Token]{init}[CallBackPhone]{14089971698}[OutDial_ID]{789}[

OutDial_OnNotConnected]{c:\toa\callout\UGI_trial\ugi_notcon.vgs}[OutDial_AnswerTimeout]{29}[OutDial_RetriesLeft]{0}[OutDial_

PauseBetweenRetries]{5}]

190440.25 2 script interpretor: VgMulti v6.0.3386

190440.25 2 state Dialing 99338104

190440.27 2 lineMakeCall=>[]

190440.27 2 timer set 39 EV_TIMEOUT_MAKECALL_NORESPONSE

190440.81 2 tw DialogicEvent 135,TDX_SETHOOK,0,0,0,DX_OFFHOOK,CALL_OUTBOUND,

190440.81 2 event TDX_SETHOOK, iCode=135 state=5200

190440.81 2 LsWaitAfterDialingOut : 135,TDX_SETHOOK,0,0,0,DX_OFFHOOK,CALL_OUTBOUND,

190500.88 2 tw DialogicEvent 134,TDX_CST,191,0,0,DE_TONEON,FAX,

190500.88 2 event FAX, iCode=134 state=5200

190500.88 2 LsWaitAfterDialingOut : 134,FAX,191,0,0,DE_TONEON,FAX,

190500.88 2 event TDX_CST, iCode=134 state=5200

190500.88 2 LsWaitAfterDialingOut : 134,TDX_CST,191,0,0,DE_TONEON,FAX,

190500.89 2 tw DialogicEvent 133,TDX_CALLP,18,0,0,CR_FAXTONE,,

190500.89 2 event CR_FAXTONE, iCode=133 state=5200

190500.89 2 LsWaitAfterDialingOut : 133,CR_FAXTONE,18,0,0,,,

190500.89 2 event TDX_CALLP, iCode=133 state=5200

190500.89 2 LsWaitAfterDialingOut : 133,TDX_CALLP,18,0,0,CR_FAXTONE,,

190500.89 2 DialoutProcessFailedDial start sCalledFrom=[LsWaitAfterDialingOut-CR_FAXTONE] RetriesLeft=0

190500.89 2 rvns add [OutDial_Result]{Uncontactable_FaxAnswer}

190500.89 2 timer clear bForceClear=False

190500.89 2 OnNotConnected unknown app [c:\toa\callout\UGI_trial\ugi_notcon.vgs]

190500.89 2 dial no escalation info

190500.89 2 HangupCall start (CR_FAXTONE in LsWaitAfterDialingOut)

190500.89 2 rv add [Hangup Time]{10/29/2008 7:05:00 PM}

190500.89 2 state Hanging up call... [CR_FAXTONE in LsWaitAfterDialingOut]

190500.89 2 HangupCall_Common hCall=0

190500.89 2 play PlayStop ok

190500.89 2 timer set 1 EV_TIMEOUT_DOLINEDROP

190500.89 2 state Waiting for a call...

190500.89 2 fnHangupCall end

190500.89 2 tw DialogicEvent 134,TDX_CST,3381,0,0,DE_LCON,,

190500.89 2 event TDX_CST, iCode=134 state=900

190500.89 2 LsAwaitingCalls EV_UNKNOWN_134

190501.97 2 timer fired EV_TIMEOUT_DOLINEDROP

190501.97 2 event EV_TIMEOUT_DOLINEDROP, iCode=9102 state=900

190501.97 2 timer set 2 EV_TIMEOUT_WAITFORIDLEAFTERLINEDROP

190501.00 2 tw DialogicEvent 135,TDX_SETHOOK,0,0,0,DX_ONHOOK,,

190501.00 2 event TDX_SETHOOK, iCode=135 state=900

190501.00 2 LsAwaitingCalls EV_UNKNOWN_135

190501.00 2 event callstate IDLE 2 1,0,0

190501.00 2 WorkingMode@Idle=

190501.00 2 set LineState().hCall = 0 LineEvCallState-LINECALLSTATE_IDLE

190501.00 2 timer clear bForceClear=True

190501.00 2 LineState(iLineId).iVgsIdx = 0

190501.00 2 timer set 0.3 EV_TIMEOUT_TIMETOREINITLINE

190502.30 2 timer fired EV_TIMEOUT_TIMETOREINITLINE

190502.30 2 event EV_TIMEOUT_TIMETOREINITLINE, iCode=9008 state=900

190502.30 2 init atidle reinit : start

190502.30 2 init atidle reinit iConferenceOtherLegLid=-1

190502.30 2 init atidle reinit : reset all LineState variables

190502.30 2 timer set 2 EV_TIMEOUT_AFTERIDLE_ALLOWOUT

190502.30 2 state Waiting for a call...

190504.50 2 timer fired EV_TIMEOUT_AFTERIDLE_ALLOWOUT

190504.50 2 event EV_TIMEOUT_AFTERIDLE_ALLOWOUT, iCode=9013 state=900

190504.50 2 setting iDialoutReadyToDialout = 1

Share this post


Link to post

So when you say "Hello" or similar the Dialogic card reports it as a fax machine?

 

You may want to try changing the fax tone definition in the ConfigLine.xml file to something that is unlikely to be detected, eg:

 

<Tone Name="Call Progress Tone TID_FAX1">

<Notes>undetectable</Notes>

<ID>TID_FAX1</ID>

<Freq1>3000</Freq1>

<Freq1Dev>50</Freq1Dev>

<Freq2>0</Freq2>

<Freq2Dev>0</Freq2Dev>

<On>1000</On>

<OnDev>10</OnDev>

<Off>0</Off>

<OffDev>0</OffDev>

<Count>10</Count>

</Tone>

 

<Tone Name="Call Progress Tone TID_FAX2">

<Notes>undetectable</Notes>

<ID>TID_FAX1</ID>

<Freq1>3000</Freq1>

<Freq1Dev>50</Freq1Dev>

<Freq2>0</Freq2>

<Freq2Dev>0</Freq2Dev>

<On>1000</On>

<OnDev>10</OnDev>

<Off>0</Off>

<OffDev>0</OffDev>

<Count>10</Count>

</Tone>

 

The ktTel trace of the whole call would better show us what is going on here. ie. what were the current TID_FAX1/TID_FAX2 settings and which one was detected etc.

Share this post


Link to post

Feel I'd better ask instead of figuring out myself. KtTel trace is at bottom. On 190500.889 002, it's determined the other side is FAX. Our configLine.xml for fax is as following also: Use your fax line configuration will eliminate the problem?

 

<Tone Name="Call Progress Tone TID_FAX1">

<Notes>Default Setting</Notes>

<ID>TID_FAX1</ID>

<Freq1>2150</Freq1>

<Freq1Dev>50</Freq1Dev>

<Freq2>0</Freq2>

<Freq2Dev>0</Freq2Dev>

<On>25</On>

<OnDev>25</OnDev>

<Off>0</Off>

<OffDev>0</OffDev>

<Count>1</Count>

</Tone>

 

<Tone Name="Call Progress Tone TID_FAX2">

<Notes>Default Setting</Notes>

<ID>TID_FAX2</ID>

<Freq1>1100</Freq1>

<Freq1Dev>50</Freq1Dev>

<Freq2>0</Freq2>

<Freq2Dev>0</Freq2Dev>

<On>25</On>

<OnDev>25</OnDev>

<Off>0</Off>

<OffDev>0</OffDev>

<Count>1</Count>

</Tone>

 

 

 

 

 

********************************************************************************

****************

190423.842 002 ocxfn PlayStart(hLine=2, strSoundFile=[C:\toa\ugivoice\UGI_Callout_Voice\64732745.wav], lPlayId=730031(0xb23af), lParam1=0, lParam2=0, strParam1=, strParam2=, keys[NotUsed])

190423.842 002 ocxfn PlaySetControlKeys(2,0,,,,,,,,,,)

190423.842 002 ocxfn PlaySetControlKeys end

190423.842 002 play start (hli=0x1d2c30, strSoundFile=C:\toa\ugivoice\UGI_Callout_Voice\64732745.wav, lPlayId=730031(0xb23af), lParam1=0, lParam2=0, strParam1=, strParam2=)

190423.842 pcm sample_bytes=2, data_size=32000 _

190423.842 pcm data_size_div2=16000, ptrVoiceData_Current=0xb967ad0

190423.858 fread 16001 pcm16 bytes

190423.858 iReadCount test 16001

190423.858 iFilesQueued test 1

190423.858 002 buffer workaround (15999) (2 bytes truncated from end of each file)

190423.905 002 dlgc dx_clrsvcond(2) => 0

190423.905 002 wFileFormat=8, (pcm=8, adpcm=1)

190423.905 002 iott 0xb965ee8 io_type=0xc, io_fhandle=0, io_bufp=0xb96f7e8, io_offset=0, io_length=15999, io_nextp=0x0, io_prevp=0x0, rfu=0x0

190423.905 002 dlgc play(2, 0xb965ee8, 0x0, 0x1d6120, EV_ASYNC) call

190423.905 002 dlgc play(2, 0xb965ee8, 0x0, 0x1d6120) => 0, hli=0x1d2c30

190425.967 002 gc_GetMetaEvent returned. iDev=0, lEvtType=2, pEvtData=0x81, lEvtDataLen=86719760

190425.967 002 ev TDX_PLAY (Play Completed)

190425.967 002 cleared dwPlayId: hli=0x1d2c30, hli->dwPlayId=0(0x0)

190425.967 002 ocxev PlayEnd(dwLineId=2, dwPlayId=730031)

190425.967 002 ocxev DoFireDialogic(dwIdx=797, 2, 129, [TDX_PLAY], 730031, 0, 0, [], [], []) (dwIdx=797)

190425.967 002 ocxev DoFireDialogic completed

190425.967 002 ocxfn PlayStop(hLine=2, lPlayId=0(0x0), lParam1=0, lParam2=0, strParam1=, strParam2=)

190425.967 002 dx_stopch call in PlayStop

190425.967 002 dx_stopch 2 ok

190427.030 002 ocxfn LineDrop(sLineId=2, , lParam1=0, lParam2=0, strParam1=, strParam2=0)

190427.030 002 dx_sethook(2) call

190427.030 002 dx_sethook 2 DX_ONHOOK ok

190427.061 002 gc_GetMetaEvent returned. iDev=0, lEvtType=2, pEvtData=0x87, lEvtDataLen=86719760

190427.061 002 ev TDX_SETHOOK (SetHook Completed)

190427.061 002 ocxev DoFireDialogic(dwIdx=798, 2, 135, [TDX_SETHOOK], 0, 0, 0, [DX_ONHOOK], [], []) (dwIdx=798)

190427.061 002 ocxev DoFireDialogic completed

190427.061 002 te LINE_CALLSTATE(2, 0x2, 0x1, 0x0, 0x0) LINE_CALLSTATE-LINECALLSTATE_IDLE

190427.061 002 ocxfn RecStop(hLine=2, lRecId=0, lParam1=0, lParam2=0, strParam1=, strParam2=)

190427.061 002 dx_stopch call in RecStop

190427.061 002 dx_stopch 2 ok

190427.077 002 ocxfn PlayStop(hLine=2, lPlayId=0(0x0), lParam1=0, lParam2=0, strParam1=, strParam2=)

190427.077 002 dx_stopch call in PlayStop

190427.077 002 dx_stopch 2 ok

190428.514 002 ocxfn RingsBeforeAnswer(lLineId=2, lRings=0, lParam1=0, strParam2=)

190429.014 002 lTimer_RingsIgnore_InGuardTimeAfterHangup=0

190440.249 002 ocxfn LineMakeCall(linedev=2, hcall=0, 99338104, callprog=DX_PAMDOPTEN, timeout=29, params:[0,0,cid=,]) chdev=2, dtidev=0

190440.249 002 makecall protocol is: non-ISDN

190440.249 route resources (dxxxB1C2) call

190440.249 dlgc scbus set DevType1 = LSI, sDlgcDevName=dxxxB1C2

190440.249 dlgc this channel does not link to a bus timeslot

190440.264 dx_sethook(2, DX_OFFHOOK) ok

190440.811 002 gc_GetMetaEvent returned. iDev=0, lEvtType=2, pEvtData=0x87, lEvtDataLen=86719760

190440.811 002 ev TDX_SETHOOK (SetHook Completed)

190440.811 002 ocxev DoFireDialogic(dwIdx=800, 2, 135, [TDX_SETHOOK], 0, 0, 0, [DX_OFFHOOK], [CALL_OUTBOUND], []) (dwIdx=800)

190440.811 002 lAtdx_LineSt=0x10:RLS_RING| lAtdx_State=0x1:CS_IDLE

190440.811 002 loop current is present. RLS_LCSENSE flag not set.

190440.811 setting call progress tones according to [C:\Program Files\VoiceGuide\data\ConfigLine.xml] as hli->iReadTonesConfigFromConfigLineXml=1

190440.811 002 ocxev DoFireDialogic completed

190440.811 002 dlgc dx_deltones(2) returned ok (DelTones_SetTones_InitCallProgress)

190440.811 tone an id:FAX:191, f1:1100:110, cad:30:15:0:0, count:0

190440.827 tone description save hli=0x1d2c30, iToneUserID[0]=191 sToneUserName[0]=[FAX]

190440.827 tone an id:DISCONNECT_TAPI1 192 f1:620:200, f2:480:200, cad:30:10:20:10, count:3

190440.827 tone description save hli=0x1d2c30, iToneUserID[1]=192 sToneUserName[1]=[DISCONNECT_TAPI1]

190440.827 tone an id:DISCONNECT_TAPI2:193, f1:550:200, cad:30:10:20:10, count:3

190440.842 tone description save hli=0x1d2c30, iToneUserID[2]=193 sToneUserName[2]=[DISCONNECT_TAPI2]

190440.842 tone ch id:TID_DIAL_LCL:250, f1:340:40, f2:440:40, cad:100:0,0:0, count:1 (arridx=59)

190440.842 tone ch id:TID_DIAL_INTL:251, f1:340:40, f2:440:40, cad:100:0,0:0, count:1 (arridx=60)

190440.842 tone ch id:TID_DIAL_XTRA:252, f1:340:40, f2:440:40, cad:100:0,0:0, count:1 (arridx=61)

190440.842 tone ch id:TID_BUSY1:253, f1:500:200, f2:0:0, cad:55:40,55:40, count:4 (arridx=62)

190440.842 tone ch id:TID_RNGBK1:254, f1:438:138, f2:0:0, cad:130:105,400:200, count:1 (arridx=63)

190440.842 tone ch id:TID_BUSY2:255, f1:500:200, f2:525:175, cad:55:40,55:40, count:4 (arridx=64)

190440.842 tone ch id:TID_DISCONNECT:257, f1:500:200, f2:525:175, cad:55:40,55:40, count:4 (arridx=66)

190440.842 tone ch id:TID_FAX1:258, f1:2150:50, f2:0:0, cad:25:25,0:0, count:1 (arridx=67)

190440.842 tone ch id:TID_FAX2:259, f1:1100:50, f2:0:0, cad:25:25,0:0, count:1 (arridx=68)

190440.874 002 cp_init(2) returned ok (DelTones_SetTones_InitCallProgress)

190440.874 dx_dial([99338104], with call progress) ok

190500.874 002 gc_GetMetaEvent returned. iDev=0, lEvtType=2, pEvtData=0x86, lEvtDataLen=193755944

190500.874 002 ev TDX_CST (CST Event Received)

190500.874 002 ev TDX_CST DE_TONEON cst_data=191

190500.874 002 tone description retrieve hli=0x1d2c30, iToneUserID[0]=191 sToneUserName[0]=[FAX]

190500.874 002 ocxev DoFireDialogic(dwIdx=801, 2, 134, [TDX_CST], 191, 0, 0, [DE_TONEON], [FAX], []) (dwIdx=801)

190500.874 002 ocxev DoFireDialogic completed

190500.889 002 gc_GetMetaEvent returned. iDev=0, lEvtType=2, pEvtData=0x85, lEvtDataLen=86719760

190500.889 002 ev TDX_CALLP (Call Progress Completed)

190500.889 002 TDX_CALLP CR_FAXTONE (called line was answered by a fax machine or a modem (PerfectCall Call Analysis only))

190500.889 002 ocxev DoFireDialogic(dwIdx=802, 2, 133, [TDX_CALLP], 18, 0, 0, [CR_FAXTONE], [], []) (dwIdx=802)

190500.889 002 gc_GetMetaEvent returned. iDev=0, lEvtType=2, pEvtData=0x86, lEvtDataLen=86719760

190500.889 002 ev TDX_CST (CST Event Received)

190500.889 002 ev TDX_CST DE_LCON data=3381

190500.889 002 ocxfn PlayStop(hLine=2, lPlayId=0(0x0), lParam1=0, lParam2=0, strParam1=, strParam2=)

190500.889 002 dx_stopch call in PlayStop

190500.889 002 dx_stopch 2 ok

Share this post


Link to post

Create an account or sign in to comment

You need to be a member in order to leave a comment

Create an account

Sign up for a new account in our community. It's easy!

Register a new account

Sign in

Already have an account? Sign in here.

Sign In Now
×