Pots to Pots Faxing on a Cisco Gateway w/out Call Manager

Hi,
 
  I am working on a gateway and here is the scenario.

The user has sip trunks to an IPPBX (non Cisco).  The user has an FXS card in the system.  A standard PRI provides dial tone through the gateway.

We seem to be unable to send faxes out through the FXS port.  All we see in a debug of the call is the system sending the first 4 digits the the call fails.  We can receive faxes just fine.

Here are the dial peers and relevant config:

network-clock-participate wic 1
network-clock-select 1 T1 0/1/0
!
ip source-route
!
!
ip cef
!
!
no ip domain lookup
no ipv6 cef
multilink bundle-name authenticated
!
!
!
!
isdn switch-type primary-ni
!
!
voice call carrier capacity active
!
voice service voip
 allow-connections h323 to h323
 allow-connections h323 to sip
 allow-connections sip to h323
 allow-connections sip to sip
 fax protocol cisco
 h323
 sip
!
!
!
voice class codec 1
 codec preference 1 g711alaw
!
!
!
!
voice class h323 1
  h225 timeout tcp establish 30
  telephony-service ccm-compatible
  ccm-compatible
!
!
!
!
!
!
!
!
!
!
!
!
voice-card 0
 dsp services dspfarm
!
!
application
 global
  service alternate default
 !
!
!
!
controller T1 0/1/0
 cablelength short 110
 pri-group timeslots 1-10,24
!
ip tcp synwait-time 13
!
!
!
!

!
interface Serial0/1/0:23
 no ip address
 encapsulation hdlc
 isdn switch-type primary-ni
 isdn incoming-voice voice
 no cdp enable
!

!
control-plane
!
!
!
voice-port 0/0/0
 input gain -3
 impedance 600c
 description Fax XXX-XXX-1199
!
voice-port 0/0/1
 input gain -3
 impedance 600c
!
voice-port 0/1/0:23
 input gain 3
 output attenuation 3
!
no ccm-manager fax protocol cisco
!
no mgcp package-capability res-package
no mgcp package-capability fxr-package
no mgcp timer receive-rtcp
mgcp fax t38 ecm
no mgcp explicit hookstate
!
!
!
dial-peer voice 999000 pots
 port 0/0/0
!
dial-peer voice 999001 pots
 port 0/0/1
!
dial-peer voice 911 pots
 destination-pattern 911
 no digit-strip
 port 0/1/0:23
!
dial-peer voice 9911 pots
 destination-pattern 9911
 no digit-strip
 port 0/1/0:23
 forward-digits 3
!
dial-peer voice 1 pots
 description SRST Dial Pattern
 destination-pattern 9T
 port 0/1/0:23
 forward-digits 10
!
dial-peer voice 2 pots
 description SRST Dial Pattern
 destination-pattern 91T
 port 0/1/0:23
 forward-digits 11
!
dial-peer voice 604268 pots
 destination-pattern 98021236549
 port 0/1/0:23
 forward-digits 10
!
dial-peer voice 10210 pots
 destination-pattern 1199
 port 0/0/0
!
dial-peer voice 10211 pots
 port 0/0/1
!
dial-peer voice 40 voip
 preference 1
 destination-pattern .......
 session protocol sipv2
 session target ipv4:PrimaryPBX
 dtmf-relay rtp-nte
 codec g711ulaw
 no vad
!
dial-peer voice 41 voip
 preference 2
 destination-pattern .......
 session protocol sipv2
 session target ipv4:SecondaryPBX
 dtmf-relay rtp-nte
 codec g711ulaw
 no vad
!
dial-peer voice 101 pots
 description *** Company #1 Local PSTN Calling ***
 preference 1
 destination-pattern 9[2-9].........
 incoming called-number .
 direct-inward-dial
 port 0/1/0:23
 forward-digits 10
!
dial-peer voice 115 pots
 description *** Company #1 Long Distance Calling ***
 preference 1
 destination-pattern 91[2-9]..[2-9]......
 direct-inward-dial
 port 0/1/0:23
 forward-digits 11
!
dial-peer voice 42 voip
 description 4 digit inbound
 preference 1
 destination-pattern ....
 session protocol sipv2
 session target ipv4:PrimaryPBX
 dtmf-relay rtp-nte
 codec g711ulaw
 no vad
!
dial-peer voice 43 voip
 description 4 digit inbound
 preference 2
 destination-pattern ....
 session protocol sipv2
 session target ipv4:SecondaryPBX
 dtmf-relay rtp-nte
 codec g711ulaw
 no vad
!
!
sip-ua
 retry invite 3
!

Here is a debug: the number called was 9503XXXXXXX

Jan  6 22:03:08.882: //473/07DFEF90849C/CCAPI/cc_api_call_disconnected:
   Cause Value=16, Interface=0x48346EC0, Call Id=473
Jan  6 22:03:08.882: //473/07DFEF90849C/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)
Jan  6 22:03:08.882: //473/07DFEF90849C/CCAPI/ccConferenceDestroy:
   Conference Id=0xBF, Tag=0x0
Jan  6 22:03:08.882: //473/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0xBF, Source Interface=0x48346EC0, Source Call Id=473,
   Destination Call Id=475, Disposition=0x0, Tag=0x0
Jan  6 22:03:08.882: //475/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0xBF, Source Interface=0x4899A7A0, Source Call Id=475,
   Destination Call Id=473, Disposition=0x0, Tag=0x0
Jan  6 22:03:08.882: //473/07DFEF90849C/CCAPI/cc_generic_bridge_done:
   Conference Id=0xBF, Source Interface=0x4899A7A0, Source Call Id=475,
   Destination Call Id=473, Disposition=0x0, Tag=0x0
Jan  6 22:03:08.882: //475/07DFEF90849C/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
Jan  6 22:03:08.882: //475/07DFEF90849C/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Jan  6 22:03:08.882: //475/07DFEF90849C/CCAPI/cc_api_get_transfer_info:
   Transfer Number Is Null
Jan  6 22:03:08.886: //473/07DFEF90849C/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
Jan  6 22:03:08.886: //473/07DFEF90849C/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Jan  6 22:03:08.886: //473/07DFEF90849C/CCAPI/cc_api_get_transfer_info:
   Transfer Number Is Null
Jan  6 22:03:08.890: //473/07DFEF90849C/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x48346EC0, Tag=0x0, Call Id=473,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Jan  6 22:03:08.890: //473/07DFEF90849C/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Jan  6 22:03:08.890: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
 
Jan  6 22:03:08.890: :cc_free_feature_vsa freeing 46BF5200
Jan  6 22:03:08.890: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
 
Jan  6 22:03:08.890:  vsacount in free is 1
Jan  6 22:03:08.950: //475/07DFEF90849C/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x4899A7A0, Tag=0x0, Call Id=475,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Jan  6 22:03:08.954: //475/07DFEF90849C/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Jan  6 22:03:08.954: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
 
Jan  6 22:03:08.954: :cc_free_feature_vsa freeing 46BF5120
Jan  6 22:03:08.954: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
 
Jan  6 22:03:08.954:  vsacount in free is 0
Jan  6 22:03:18.682: //-1/2FC87B5F84A2/CCAPI/cc_api_display_ie_subfields:
   cc_api_call_setup_ind_common:
   cisco-username=
   ----- ccCallInfo IE subfields -----
   cisco-ani=
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-lastrdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=0   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0
 
Jan  6 22:03:18.686: //-1/2FC87B5F84A2/CCAPI/cc_api_call_setup_ind_common:
   Interface=0x48346EC0, Call Info(
   Calling Number=,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=(TON=Unknown, NPI=Unknown),
   Calling Translated=FALSE, Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE,
   Incoming Dial-peer=10210, Progress Indication=ORIGINATING SIDE IS NON ISDN(3), Calling IE Present=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, CLID Transparent=FALSE), Call Id=-1
Jan  6 22:03:18.686: //-1/2FC87B5F84A2/CCAPI/ccCheckClipClir:
   In: Calling Number=1199(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Jan  6 22:03:18.686: //-1/2FC87B5F84A2/CCAPI/ccCheckClipClir:
   Out: Calling Number=1199(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Jan  6 22:03:18.686: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
 
Jan  6 22:03:18.686: :cc_get_feature_vsa malloc success
Jan  6 22:03:18.686: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
 
Jan  6 22:03:18.686:  cc_get_feature_vsa count is 1
Jan  6 22:03:18.686: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
 
Jan  6 22:03:18.686: :FEATURE_VSA attributes are: feature_name:0,feature_time:1185906648,feature_id:459
Jan  6 22:03:18.686: //476/2FC87B5F84A2/CCAPI/cc_api_call_setup_ind_common:
   Set Up Event Sent;
   Call Info(Calling Number=1199(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=(TON=Unknown, NPI=Unknown))
Jan  6 22:03:18.686: //476/2FC87B5F84A2/CCAPI/cc_process_call_setup_ind:
   Event=0x47B741C0
Jan  6 22:03:18.690: //476/2FC87B5F84A2/CCAPI/ccCallSetContext:
   Context=0x48D5689C
Jan  6 22:03:18.690: //476/2FC87B5F84A2/CCAPI/cc_process_call_setup_ind:
   >>>>CCAPI handed cid 476 with tag 10210 to app "_ManagedAppProcess_Default"
Jan  6 22:03:18.690: //476/2FC87B5F84A2/CCAPI/ccCallSetupAck:
   Call Id=476
Jan  6 22:03:18.690: //476/2FC87B5F84A2/CCAPI/cc_api_set_transfer_info:
   Transfer Number=, Transfer Reason=0x0
Jan  6 22:03:18.690: //476/2FC87B5F84A2/CCAPI/ccGenerateToneInfo:
   Stop Tone On Digit=TRUE, Tone=Dial Tone,
   Tone Direction=Network, Params=0x0, Call Id=476
Jan  6 22:03:18.690: //476/2FC87B5F84A2/CCAPI/ccSetDigitTimeouts:
   Initial Digit Timeout=-1000(ms), Inter Digit Timeout=-1000(ms)
Jan  6 22:03:18.690: //476/2FC87B5F84A2/CCAPI/ccSetDigitTimeouts:
   Call Entry(Inter Digit Timeout=10000(ms), Initial Digit Timeout=10000(ms))
Jan  6 22:03:18.690: //476/xxxxxxxxxxxx/CCAPI/ccCallReportDigits:
   (callID=0x1DC, digit_event=0x1, enable=TRUE, consume=FALSE)
Jan  6 22:03:18.690: //476/2FC87B5F84A2/CCAPI/ccCallReportDigits:
   Enabled=TRUE, Call Id=476
Jan  6 22:03:18.690: //476/xxxxxxxxxxxx/CCAPI/cc_api_call_report_digits_done:
   (vdbPtr=0x48346EC0, callID=0x1DC, disp=0, digit_event=0x1, enable=TRUE, consume=FALSE)
Jan  6 22:03:18.690: //476/2FC87B5F84A2/CCAPI/cc_api_call_report_digits_done:
   Enabled=TRUE, Disposition=0x0, Interface=0x48346EC0, Call Id=476
Jan  6 22:03:18.690: //476/2FC87B5F84A2/CCAPI/cc_api_call_report_digits_done:
   Call Entry(Initial Digit Timeout=15000(ms), Inter Digit Timeout=10000(ms))
Jan  6 22:03:20.822: //476/2FC87B5F84A2/CCAPI/cc_api_call_digit_begin:
   Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=-1,
   Source Call Id=476, Digit=9, DigitBeginFlags=0x1,
   Rtp Timestamp=0x669011D4, Rtp Expiration=0x0
Jan  6 22:03:20.914: //476/2FC87B5F84A2/CCAPI/cc_api_call_digit_end:
   Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=-1,
   Source Call Id=476, Digit=9, Duration=127,
   Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Jan  6 22:03:20.914: //476/2FC87B5F84A2/CCAPI/cc_api_call_digit_end:
   Call Entry(Handoff Depth=0)
Jan  6 22:03:21.022: //476/2FC87B5F84A2/CCAPI/cc_api_call_digit_begin:
   Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=-1,
   Source Call Id=476, Digit=6, DigitBeginFlags=0x1,
   Rtp Timestamp=0x66901819, Rtp Expiration=0x0
Jan  6 22:03:21.114: //476/2FC87B5F84A2/CCAPI/cc_api_call_digit_end:
   Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=-1,
   Source Call Id=476, Digit=6, Duration=122,
   Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Jan  6 22:03:21.114: //476/2FC87B5F84A2/CCAPI/cc_api_call_digit_end:
   Call Entry(Handoff Depth=0)
Jan  6 22:03:21.222: //476/2FC87B5F84A2/CCAPI/cc_api_call_digit_begin:
   Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=-1,
   Source Call Id=476, Digit=0, DigitBeginFlags=0x1,
   Rtp Timestamp=0x66901E54, Rtp Expiration=0x0
Jan  6 22:03:21.314: //476/2FC87B5F84A2/CCAPI/cc_api_call_digit_end:
   Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=-1,
   Source Call Id=476, Digit=0, Duration=127,
   Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Jan  6 22:03:21.314: //476/2FC87B5F84A2/CCAPI/cc_api_call_digit_end:
   Call Entry(Handoff Depth=0)
Jan  6 22:03:21.422: //476/2FC87B5F84A2/CCAPI/cc_api_call_digit_begin:
   Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=-1,
   Source Call Id=476, Digit=4, DigitBeginFlags=0x1,
   Rtp Timestamp=0x66902496, Rtp Expiration=0x0
Jan  6 22:03:21.514: //476/2FC87B5F84A2/CCAPI/cc_api_call_digit_end:
   Destination Interface=0x0, Destination Mask=0x1, Destination Call Id=-1,
   Source Call Id=476, Digit=4, Duration=125,
   Xrule Calling Tag=0, Xrule Called Tag=0, Digit Tone Mode=DTMF
Jan  6 22:03:21.514: //476/2FC87B5F84A2/CCAPI/cc_api_call_digit_end:
   Call Entry(Handoff Depth=0)
Jan  6 22:03:21.514: //476/xxxxxxxxxxxx/CCAPI/ccCallReportDigits:
   (callID=0x1DC, digit_event=0x0, enable=FALSE, consume=FALSE)
Jan  6 22:03:21.514: //476/2FC87B5F84A2/CCAPI/ccCallReportDigits:
   Enabled=TRUE, Call Id=476
Jan  6 22:03:21.514: //476/xxxxxxxxxxxx/CCAPI/cc_api_call_report_digits_done:
   (vdbPtr=0x48346EC0, callID=0x1DC, disp=0, digit_event=0x0, enable=FALSE, consume=FALSE)
Jan  6 22:03:21.514: //476/2FC87B5F84A2/CCAPI/cc_api_call_report_digits_done:
   Enabled=TRUE, Disposition=0x0, Interface=0x48346EC0, Call Id=476
Jan  6 22:03:21.514: //476/2FC87B5F84A2/CCAPI/cc_api_call_report_digits_done:
   Call Entry(Initial Digit Timeout=15000(ms), Inter Digit Timeout=10000(ms))
Jan  6 22:03:21.514: //476/2FC87B5F84A2/CCAPI/ccCallProceeding:
   Progress Indication=NULL(0)
Jan  6 22:03:21.518: //476/2FC87B5F84A2/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=TRUE, Mode=0,
   Outgoing Dial-peer=1, Params=0x48D542DC, Progress Indication=ORIGINATING SIDE IS NON ISDN(3)
Jan  6 22:03:21.518: //476/2FC87B5F84A2/CCAPI/ccCheckClipClir:
   In: Calling Number=1199(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Jan  6 22:03:21.518: //476/2FC87B5F84A2/CCAPI/ccCheckClipClir:
   Out: Calling Number=1199(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Jan  6 22:03:21.518: //476/2FC87B5F84A2/CCAPI/ccCallSetupRequest:
   Destination Pattern=9T, Called Number=9503, Digit Strip=TRUE
Jan  6 22:03:21.518: //476/2FC87B5F84A2/CCAPI/ccCallSetupRequest:
   Calling Number=1199(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=9503(TON=Unknown, NPI=Unknown),
   Redirect Number=, Display Info=
   Account Number=, Final Destination Flag=FALSE,
   Guid=2FC87B5F-FA89-11DE-84A2-90FF37B3901D, Outgoing Dial-peer=1
Jan  6 22:03:21.518: //476/2FC87B5F84A2/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=
   ----- ccCallInfo IE subfields -----
   cisco-ani=1199
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=9503
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-lastrdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=0   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0
 
Jan  6 22:03:21.518: //476/2FC87B5F84A2/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x4899A7A0, Interface Type=6, Destination=, Mode=0x0,
   Call Params(Calling Number=1199,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=9503(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE, Outgoing Dial-peer=1, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
Jan  6 22:03:21.518: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
 
Jan  6 22:03:21.518: :cc_get_feature_vsa malloc success
Jan  6 22:03:21.518: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
 
Jan  6 22:03:21.518:  cc_get_feature_vsa count is 2
Jan  6 22:03:21.518: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
 
Jan  6 22:03:21.518: :FEATURE_VSA attributes are: feature_name:0,feature_time:1185906424,feature_id:460
Jan  6 22:03:21.522: //477/2FC87B5F84A2/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1
Jan  6 22:03:21.522: //477/2FC87B5F84A2/CCAPI/ccCallSetContext:
   Context=0x48D5428C
Jan  6 22:03:21.522: //476/2FC87B5F84A2/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=1
Jan  6 22:03:21.698: //477/2FC87B5F84A2/CCAPI/cc_api_call_proceeding:
   Interface=0x4899A7A0, Progress Indication=NULL(0)
Jan  6 22:03:21.706: //477/2FC87B5F84A2/CCAPI/cc_api_call_cut_progress:
   Interface=0x4899A7A0, Progress Indication=INBAND(8), Signal Indication=INTERCEPT(2),
   Cause Value=4
Jan  6 22:03:21.706: //477/2FC87B5F84A2/CCAPI/cc_api_call_cut_progress:
   Call Entry(Responsed=TRUE)
Jan  6 22:03:21.710: //476/2FC87B5F84A2/CCAPI/ccCallCutProgress:
   Progress Indication=INBAND(8), Signal Indication=INTERCEPT(2), Cause Value=4
   Voice Call Send Alert=FALSE, Call Entry(Alert Sent=FALSE)
Jan  6 22:03:21.710: //476/2FC87B5F84A2/CCAPI/ccCallCutProgress:
   Call Entry(Responsed=TRUE)
Jan  6 22:03:21.710: //476/2FC87B5F84A2/CCAPI/ccGenerateToneInfo:
   Stop Tone On Digit=FALSE, Tone=Null,
   Tone Direction=Network, Params=0x0, Call Id=476
Jan  6 22:03:21.710: //476/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0x48CE7024, callID1=0x1DC, callID2=0x1DD, tag=0x0)
Jan  6 22:03:21.710: //476/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0x48CE7024, callID1=0x1DC, gcid=2FC87B5F-FA8911DE-84A290FF-37B3901D, tag=0x0)
Jan  6 22:03:21.710: //477/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0x48CE7024, callID2=0x1DD, gcid=2FC87B5F-FA8911DE-84A290FF-37B3901D, tag=0x0)
Jan  6 22:03:21.710: //476/2FC87B5F84A2/CCAPI/ccConferenceCreate:
   Conference Id=0x48CE7024, Call Id1=476, Call Id2=477, Tag=0x0
Jan  6 22:03:21.710: //476/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0xC0, Source Interface=0x48346EC0, Source Call Id=476,
   Destination Call Id=477, Disposition=0x0, Tag=0xFFFFFFFF
Jan  6 22:03:21.710: //477/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0xC0, Source Interface=0x4899A7A0, Source Call Id=477,
   Destination Call Id=476, Disposition=0x0, Tag=0xFFFFFFFF
Jan  6 22:03:21.710: //476/2FC87B5F84A2/CCAPI/cc_generic_bridge_done:
   Conference Id=0xC0, Source Interface=0x4899A7A0, Source Call Id=477,
   Destination Call Id=476, Disposition=0x0, Tag=0xFFFFFFFF
Jan  6 22:03:21.710: //476/2FC87B5F84A2/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0xC0, Destination Call Id=477)
Jan  6 22:03:21.710: //477/2FC87B5F84A2/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0xC0, Destination Call Id=476)
Jan  6 22:03:21.710: //476/2FC87B5F84A2/CCAPI/cc_api_caps_ind:
   Destination Interface=0x4899A7A0, Destination Call Id=477, Source Call Id=476,
   Caps(Codec=0x1, Fax Rate=0x2, Vad=0x2,
   Modem=0x2, Codec Bytes=160, Signal Type=2)
Jan  6 22:03:21.710: //476/2FC87B5F84A2/CCAPI/cc_api_caps_ind:
   Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),
   Playout Max=1000(ms), Fax Nom=300(ms))
Jan  6 22:03:21.710: //477/2FC87B5F84A2/CCAPI/cc_api_caps_ind:
   Destination Interface=0x48346EC0, Destination Call Id=476, Source Call Id=477,
   Caps(Codec=0x1, Fax Rate=0x2, Vad=0x2,
   Modem=0x2, Codec Bytes=160, Signal Type=2)
Jan  6 22:03:21.710: //477/2FC87B5F84A2/CCAPI/cc_api_caps_ind:
   Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),
   Playout Max=1000(ms), Fax Nom=300(ms))
Jan  6 22:03:21.710: //477/2FC87B5F84A2/CCAPI/cc_api_caps_ack:
   Destination Interface=0x48346EC0, Destination Call Id=476, Source Call Id=477,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=ON(0x2),
   Modem=ON(0x2), Codec Bytes=160, Signal Type=2, Seq Num Start=9564)
Jan  6 22:03:21.714: //476/2FC87B5F84A2/CCAPI/cc_api_caps_ack:
   Destination Interface=0x4899A7A0, Destination Call Id=477, Source Call Id=476,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=ON(0x2),
   Modem=ON(0x2), Codec Bytes=160, Signal Type=2, Seq Num Start=4712)
Jan  6 22:03:21.714: //477/2FC87B5F84A2/CCAPI/cc_api_voice_mode_event:
   Call Id=477
Jan  6 22:03:21.714: //477/2FC87B5F84A2/CCAPI/cc_api_voice_mode_event:
   Call Entry(Context=0x48D5428C)
Jan  6 22:03:21.714: //476/2FC87B5F84A2/CCAPI/cc_api_voice_mode_event:
   Call Id=476
Jan  6 22:03:21.714: //476/2FC87B5F84A2/CCAPI/cc_api_voice_mode_event:
   Call Entry(Context=0x48D5689C)
Jan  6 22:03:21.714: //476/2FC87B5F84A2/CCAPI/cc_process_notify_bridge_done:
   Conference Id=0xC0, Call Id1=476, Call Id2=477
Jan  6 22:03:54.236: //477/2FC87B5F84A2/CCAPI/cc_api_call_cut_progress:
   Interface=0x4899A7A0, Progress Indication=INBAND(8), Signal Indication=INTERCEPT(2),
   Cause Value=0
Jan  6 22:03:54.236: //477/2FC87B5F84A2/CCAPI/cc_api_call_cut_progress:
   Call Entry(Responsed=TRUE)
Jan  6 22:03:54.236: //476/2FC87B5F84A2/CCAPI/ccCallProgIndProgress:
   Progress Indication=INBAND(8)
Jan  6 22:04:00.488: //477/2FC87B5F84A2/CCAPI/cc_api_call_disconnected:
   Cause Value=102, Interface=0x4899A7A0, Call Id=477
Jan  6 22:04:00.488: //477/2FC87B5F84A2/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=102, Retry Count=0)
Jan  6 22:04:00.488: //476/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources:
   release reserved xcoding resource.
Jan  6 22:04:00.488: //477/2FC87B5F84A2/CCAPI/ccCallSetAAA_Accounting:
   Accounting=1, Call Id=477
Jan  6 22:04:00.488: //476/2FC87B5F84A2/CCAPI/ccConferenceDestroy:
   Conference Id=0xC0, Tag=0x0
Jan  6 22:04:00.488: //476/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0xC0, Source Interface=0x48346EC0, Source Call Id=476,
   Destination Call Id=477, Disposition=0x0, Tag=0x0
Jan  6 22:04:00.488: //477/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0xC0, Source Interface=0x4899A7A0, Source Call Id=477,
   Destination Call Id=476, Disposition=0x0, Tag=0x0
Jan  6 22:04:00.488: //476/2FC87B5F84A2/CCAPI/cc_generic_bridge_done:
   Conference Id=0xC0, Source Interface=0x4899A7A0, Source Call Id=477,
   Destination Call Id=476, Disposition=0x0, Tag=0x0
Jan  6 22:04:00.492: //477/2FC87B5F84A2/CCAPI/ccCallDisconnect:
   Cause Value=102, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=102)
Jan  6 22:04:00.492: //477/2FC87B5F84A2/CCAPI/ccCallDisconnect:
   Cause Value=102, Call Entry(Responsed=TRUE, Cause Value=102)
Jan  6 22:04:00.492: //477/2FC87B5F84A2/CCAPI/cc_api_get_transfer_info:
   Transfer Number Is Null
Jan  6 22:04:00.516: //477/2FC87B5F84A2/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x4899A7A0, Tag=0x0, Call Id=477,
   Call Entry(Disconnect Cause=102, Voice Class Cause Code=0, Retry Count=0)
Jan  6 22:04:00.516: //477/2FC87B5F84A2/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Jan  6 22:04:00.516: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
 
Jan  6 22:04:00.516: :cc_free_feature_vsa freeing 46AF7EF0
Jan  6 22:04:00.516: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
 
Jan  6 22:04:00.516:  vsacount in free is 1
Jan  6 22:04:00.520: //476/2FC87B5F84A2/CCAPI/ccCallSetupRequest:
   Destination=, Calling IE Present=TRUE, Mode=0,
   Outgoing Dial-peer=2000, Params=0x48D4F6BC, Progress Indication=ORIGINATING SIDE IS NON ISDN(3)
Jan  6 22:04:00.520: //476/2FC87B5F84A2/CCAPI/ccCheckClipClir:
   In: Calling Number=1199(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Jan  6 22:04:00.520: //476/2FC87B5F84A2/CCAPI/ccCheckClipClir:
   Out: Calling Number=1199(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed)
Jan  6 22:04:00.520: //476/2FC87B5F84A2/CCAPI/ccCallSetupRequest:
   Destination Pattern=.T, Called Number=9503, Digit Strip=TRUE
Jan  6 22:04:00.520: //476/2FC87B5F84A2/CCAPI/ccCallSetupRequest:
   Calling Number=1199(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=9503(TON=Unknown, NPI=Unknown),
   Redirect Number=, Display Info=
   Account Number=, Final Destination Flag=FALSE,
   Guid=2FC87B5F-FA89-11DE-84A2-90FF37B3901D, Outgoing Dial-peer=2000
Jan  6 22:04:00.520: //476/2FC87B5F84A2/CCAPI/cc_api_display_ie_subfields:
   ccCallSetupRequest:
   cisco-username=
   ----- ccCallInfo IE subfields -----
   cisco-ani=1199
   cisco-anitype=0
   cisco-aniplan=0
   cisco-anipi=0
   cisco-anisi=0
   dest=9503
   cisco-desttype=0
   cisco-destplan=0
   cisco-rdie=FFFFFFFF
   cisco-rdn=
   cisco-lastrdn=
   cisco-rdntype=0
   cisco-rdnplan=0
   cisco-rdnpi=0
   cisco-rdnsi=0
   cisco-redirectreason=0   fwd_final_type =0
   final_redirectNumber =
   hunt_group_timeout =0
 
Jan  6 22:04:00.520: //476/2FC87B5F84A2/CCAPI/ccIFCallSetupRequestPrivate:
   Interface=0x4899A7A0, Interface Type=6, Destination=, Mode=0x0,
   Call Params(Calling Number=1199,(Calling Name=)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
   Called Number=9503(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
   Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE, Outgoing Dial-peer=2000, Call Count On=FALSE,
   Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
Jan  6 22:04:00.520: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
 
Jan  6 22:04:00.520: :cc_get_feature_vsa malloc success
Jan  6 22:04:00.520: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
 
Jan  6 22:04:00.520:  cc_get_feature_vsa count is 2
Jan  6 22:04:00.520: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:
 
Jan  6 22:04:00.520: :FEATURE_VSA attributes are: feature_name:0,feature_time:1185906424,feature_id:461
Jan  6 22:04:00.520: //478/2FC87B5F84A2/CCAPI/ccIFCallSetupRequestPrivate:
   SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1
Jan  6 22:04:00.520: //478/2FC87B5F84A2/CCAPI/ccCallSetContext:
   Context=0x48D4F66C
Jan  6 22:04:00.520: //476/2FC87B5F84A2/CCAPI/ccSaveDialpeerTag:
   Outgoing Dial-peer=2000
Jan  6 22:04:00.668: //478/2FC87B5F84A2/CCAPI/cc_api_call_proceeding:
   Interface=0x4899A7A0, Progress Indication=NULL(0)
Jan  6 22:04:00.676: //478/2FC87B5F84A2/CCAPI/cc_api_call_cut_progress:
   Interface=0x4899A7A0, Progress Indication=INBAND(8), Signal Indication=INTERCEPT(2),
   Cause Value=4
Jan  6 22:04:00.676: //478/2FC87B5F84A2/CCAPI/cc_api_call_cut_progress:
   Call Entry(Responsed=TRUE)
Jan  6 22:04:00.676: //476/2FC87B5F84A2/CCAPI/ccCallCutProgress:
   Progress Indication=INBAND(8), Signal Indication=INTERCEPT(2), Cause Value=4
   Voice Call Send Alert=FALSE, Call Entry(Alert Sent=FALSE)
Jan  6 22:04:00.676: //476/2FC87B5F84A2/CCAPI/ccCallCutProgress:
   Call Entry(Responsed=TRUE)
Jan  6 22:04:00.676: //476/2FC87B5F84A2/CCAPI/ccGenerateToneInfo:
   Stop Tone On Digit=FALSE, Tone=Null,
   Tone Direction=Network, Params=0x0, Call Id=476
Jan  6 22:04:00.676: //476/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0x48CE70FC, callID1=0x1DC, callID2=0x1DE, tag=0x0)
Jan  6 22:04:00.676: //476/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0x48CE70FC, callID1=0x1DC, gcid=2FC87B5F-FA8911DE-84A290FF-37B3901D, tag=0x0)
Jan  6 22:04:00.676: //478/xxxxxxxxxxxx/CCAPI/ccConferenceCreate:
   (confID=0x48CE70FC, callID2=0x1DE, gcid=2FC87B5F-FA8911DE-84A290FF-37B3901D, tag=0x0)
Jan  6 22:04:00.676: //476/2FC87B5F84A2/CCAPI/ccConferenceCreate:
   Conference Id=0x48CE70FC, Call Id1=476, Call Id2=478, Tag=0x0
Jan  6 22:04:00.676: //476/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0xC1, Source Interface=0x48346EC0, Source Call Id=476,
   Destination Call Id=478, Disposition=0x0, Tag=0xFFFFFFFF
Jan  6 22:04:00.680: //478/xxxxxxxxxxxx/CCAPI/cc_api_bridge_done:
   Conference Id=0xC1, Source Interface=0x4899A7A0, Source Call Id=478,
   Destination Call Id=476, Disposition=0x0, Tag=0xFFFFFFFF
Jan  6 22:04:00.680: //476/2FC87B5F84A2/CCAPI/cc_generic_bridge_done:
   Conference Id=0xC1, Source Interface=0x4899A7A0, Source Call Id=478,
   Destination Call Id=476, Disposition=0x0, Tag=0xFFFFFFFF
Jan  6 22:04:00.680: //476/2FC87B5F84A2/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0xC1, Destination Call Id=478)
Jan  6 22:04:00.680: //478/2FC87B5F84A2/CCAPI/ccConferenceCreate:
   Call Entry(Conference Id=0xC1, Destination Call Id=476)
Jan  6 22:04:00.680: //476/2FC87B5F84A2/CCAPI/cc_api_caps_ind:
   Destination Interface=0x4899A7A0, Destination Call Id=478, Source Call Id=476,
   Caps(Codec=0x1, Fax Rate=0x2, Vad=0x2,
   Modem=0x2, Codec Bytes=160, Signal Type=2)
Jan  6 22:04:00.680: //476/2FC87B5F84A2/CCAPI/cc_api_caps_ind:
   Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),
   Playout Max=1000(ms), Fax Nom=300(ms))
Jan  6 22:04:00.680: //478/2FC87B5F84A2/CCAPI/cc_api_caps_ind:
   Destination Interface=0x48346EC0, Destination Call Id=476, Source Call Id=478,
   Caps(Codec=0x1, Fax Rate=0x2, Vad=0x2,
   Modem=0x2, Codec Bytes=160, Signal Type=2)
Jan  6 22:04:00.680: //478/2FC87B5F84A2/CCAPI/cc_api_caps_ind:
   Caps(Playout Mode=1, Playout Initial=60(ms), Playout Min=40(ms),
   Playout Max=1000(ms), Fax Nom=300(ms))
Jan  6 22:04:00.680: //478/2FC87B5F84A2/CCAPI/cc_api_caps_ack:
   Destination Interface=0x48346EC0, Destination Call Id=476, Source Call Id=478,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=ON(0x2),
   Modem=ON(0x2), Codec Bytes=160, Signal Type=2, Seq Num Start=4195)
Jan  6 22:04:00.680: //476/2FC87B5F84A2/CCAPI/cc_api_caps_ack:
   Destination Interface=0x4899A7A0, Destination Call Id=478, Source Call Id=476,
   Caps(Codec=g711ulaw(0x1), Fax Rate=FAX_RATE_VOICE(0x2), Vad=ON(0x2),
   Modem=ON(0x2), Codec Bytes=160, Signal Type=2, Seq Num Start=3122)
Jan  6 22:04:00.680: //478/2FC87B5F84A2/CCAPI/cc_api_voice_mode_event:
   Call Id=478
Jan  6 22:04:00.684: //478/2FC87B5F84A2/CCAPI/cc_api_voice_mode_event:
   Call Entry(Context=0x48D4F66C)
Jan  6 22:04:00.684: //476/2FC87B5F84A2/CCAPI/cc_api_voice_mode_event:
   Call Id=476
Jan  6 22:04:00.684: //476/2FC87B5F84A2/CCAPI/cc_api_voice_mode_event:
   Call Entry(Context=0x48D5689C)
Jan  6 22:04:00.684: //476/2FC87B5F84A2/CCAPI/cc_process_notify_bridge_done:
   Conference Id=0xC1, Call Id1=476, Call Id2=478
Jan  6 22:04:15.845: //476/2FC87B5F84A2/CCAPI/cc_api_call_disconnected:
   Cause Value=16, Interface=0x48346EC0, Call Id=476
Jan  6 22:04:15.845: //476/2FC87B5F84A2/CCAPI/cc_api_call_disconnected:
   Call Entry(Responsed=TRUE, Cause Value=16, Retry Count=0)
Jan  6 22:04:15.845: //476/2FC87B5F84A2/CCAPI/ccConferenceDestroy:
   Conference Id=0xC1, Tag=0x0
Jan  6 22:04:15.845: //476/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0xC1, Source Interface=0x48346EC0, Source Call Id=476,
   Destination Call Id=478, Disposition=0x0, Tag=0x0
Jan  6 22:04:15.845: //478/xxxxxxxxxxxx/CCAPI/cc_api_bridge_drop_done:
   Conference Id=0xC1, Source Interface=0x4899A7A0, Source Call Id=478,
   Destination Call Id=476, Disposition=0x0, Tag=0x0
Jan  6 22:04:15.845: //476/2FC87B5F84A2/CCAPI/cc_generic_bridge_done:
   Conference Id=0xC1, Source Interface=0x4899A7A0, Source Call Id=478,
   Destination Call Id=476, Disposition=0x0, Tag=0x0
Jan  6 22:04:15.845: //478/2FC87B5F84A2/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
Jan  6 22:04:15.845: //478/2FC87B5F84A2/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Jan  6 22:04:15.845: //478/2FC87B5F84A2/CCAPI/cc_api_get_transfer_info:
   Transfer Number Is Null
Jan  6 22:04:15.849: //476/2FC87B5F84A2/CCAPI/ccCallDisconnect:
   Cause Value=16, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=16)
Jan  6 22:04:15.849: //476/2FC87B5F84A2/CCAPI/ccCallDisconnect:
   Cause Value=16, Call Entry(Responsed=TRUE, Cause Value=16)
Jan  6 22:04:15.849: //476/2FC87B5F84A2/CCAPI/cc_api_get_transfer_info:
   Transfer Number Is Null
Jan  6 22:04:15.853: //476/2FC87B5F84A2/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x48346EC0, Tag=0x0, Call Id=476,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Jan  6 22:04:15.853: //476/2FC87B5F84A2/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Jan  6 22:04:15.853: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
 
Jan  6 22:04:15.853: :cc_free_feature_vsa freeing 46AF7FD0
Jan  6 22:04:15.853: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
 
Jan  6 22:04:15.853:  vsacount in free is 1
Jan  6 22:04:15.897: //478/2FC87B5F84A2/CCAPI/cc_api_call_disconnect_done:
   Disposition=0, Interface=0x4899A7A0, Tag=0x0, Call Id=478,
   Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
Jan  6 22:04:15.897: //478/2FC87B5F84A2/CCAPI/cc_api_call_disconnect_done:
   Call Disconnect Event Sent
Jan  6 22:04:15.897: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
 
Jan  6 22:04:15.897: :cc_free_feature_vsa freeing 46AF7EF0
Jan  6 22:04:15.897: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:
 
Jan  6 22:04:15.897:  vsacount in free is 0
All possible debugging has been turned off

TIA


Jim BarberTelecom/Network Systems ManagerAsked:
Who is Participating?
 
Jim BarberConnect With a Mentor Telecom/Network Systems ManagerAuthor Commented:
I resolved this myself.

the key is the dial-peers with the .... entries.

I changed the .... entries to

...T$

This causes the match to be ignored until the ITU.165 Time out occurs.  Evidently the dialpeer was matching on every digit.
0
Question has a verified solution.

Are you are experiencing a similar issue? Get a personalized answer when you ask a related question.

Have a better answer? Share it in a comment.

All Courses

From novice to tech pro — start learning today.