Can't call out through a PRI r2-digital

[FranciscoS]

Can't call out of the gateway through a r2-digital PRI.

My controller conf:

controller E1 0/2/0
framing NO-CRC4
ds0-group 1 timeslots 1-15 type r2-digital r2-compelled ani
ds0-group 2 timeslots 17-31 type r2-digital r2-compelled ani
cas-custom 1
country venezuela
release-ack
signal-end-to-end
caller-digits 9
dnis-digits min 1 max 3
dnis-complete
timer interdigit incoming 7000

The provider is receiving on the first 15 channels and sending through channels 17-31.

I can receive but i cannot start calls. I get a busy signal after a few seconds.


Jul 30 15:00:22.355: //21/FFAE38E18033/CCAPI/ccIFCallSetupRequestPrivate:
Interface=0x486FC830, Interface Type=6, Destination=, Mode=0x0,
Call Params(Calling Number=222642000,(Calling Name=Teste)(TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed),
Called Number=222440500(TON=Unknown, NPI=Unknown), Calling Translated=FALSE,
Subscriber Type Str=RegularLine, FinalDestinationFlag=FALSE, Outgoing Dial-peer=102, Call Count On=FALSE,
Source Trkgrp Route Label=, Target Trkgrp Route Label=, tg_label_flag=0, Application Call Id=)
*Jul 30 15:00:22.355: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jul 30 15:00:22.355: :cc_get_feature_vsa malloc success
*Jul 30 15:00:22.355: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jul 30 15:00:22.355: cc_get_feature_vsa count is 2
*Jul 30 15:00:22.355: //-1/xxxxxxxxxxxx/CCAPI/cc_get_feature_vsa:

*Jul 30 15:00:22.355: :FEATURE_VSA attributes are: feature_name:0,feature_time:1201983736,feature_id:22
*Jul 30 15:00:22.355: //-1/xxxxxxxxxxxx/VTSP0/2/0:1):-1:-1:-1/vtsp_allocate_cdb:
CDB=0x46B24F40
*Jul 30 15:00:22.355: //-1/xxxxxxxxxxxx/VTSP0/2/0:1):-1:-1:-1/vtsp_insert_cdb:
*Jul 30 15:00:22.355: //22/FFAE38E18033/CCAPI/ccIFCallSetupRequestPrivate:
SPI Call Setup Request Is Success; Interface Type=6, FlowMode=1
*Jul 30 15:00:22.355: //22/FFAE38E18033/CCAPI/ccCallSetContext:
Context=0x489C06EC
*Jul 30 15:00:22.355: //21/FFAE38E18033/CCAPI/ccSaveDialpeerTag:
Outgoing Dial-peer=102
*Jul 30 15:00:22.359: //21/FFAE38E18033/VTSP0/1/3):-1:1:1/act_dcollect_proc:
*Jul 30 15:00:22.359: //22/FFAE38E18033/VTSP0/2/0:1):-1:-1:-1/vtsp_og_call_req:
Echo Cancel=TRUE, Gain Control=0
Auto Gain Control=FALSE, Dual Tone Detect Mask=0x0, Seq Tone Detect=FALSE
*Jul 30 15:00:22.359: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/act_setup_req_pend_succ:
*Jul 30 15:00:22.359: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/vtsp_request_call:
Mode=0, Peer=102
*Jul 30 15:00:22.359: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/vtsp_request_call:
Progress Indication=3, Info Trans Capability=144
Calling Number=222642000, TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed
Called Number=222440500, TON=Unknown, NPI=Unknown
*Jul 30 15:00:22.671: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/act_setup_pend_proceeding:
*Jul 30 15:00:22.671: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/vtsp_timer:
Timer Start Time=249590, Timer Value=10000(ms)
*Jul 30 15:00:22.671: //22/FFAE38E18033/CCAPI/cc_api_call_proceeding:
Interface=0x486FC830, Progress Indication=NULL(0)
*Jul 30 15:00:22.671: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/act_setup_pend_proceeding:
Peer=102, Progress Indication=0, Return Code=2
*Jul 30 15:00:22.671: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/act_setup_req_pend_defer:
Event=19
*Jul 30 15:00:22.671: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/act_setup_req_pend_defer:
Event=19
*Jul 30 15:00:22.671: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/act_setup_req_wait_pend_success:
Event=73
*Jul 30 15:00:22.671: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/vtsp_timer_stop:
Timer Stop Time=249590
*Jul 30 15:00:22.671: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/act_setup_r2_pend_dial:
Digits=#, Tone Mode=1
*Jul 30 15:00:22.671: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=#
*Jul 30 15:00:22.671: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=2
*Jul 30 15:00:22.823: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=#
*Jul 30 15:00:22.927: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=1
*Jul 30 15:00:23.035: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=#
*Jul 30 15:00:23.115: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=2
*Jul 30 15:00:23.223: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=#
*Jul 30 15:00:23.327: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=2
*Jul 30 15:00:23.423: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=#
*Jul 30 15:00:23.527: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=2
*Jul 30 15:00:23.623: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=#
*Jul 30 15:00:23.727: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=6
*Jul 30 15:00:23.823: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=#
*Jul 30 15:00:23.923: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=4
*Jul 30 15:00:24.023: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=#
*Jul 30 15:00:24.123: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=2
*Jul 30 15:00:24.223: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=#
*Jul 30 15:00:24.323: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=0
*Jul 30 15:00:24.435: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=#
*Jul 30 15:00:24.515: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=0
*Jul 30 15:00:24.623: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=#
*Jul 30 15:00:24.723: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=0
*Jul 30 15:00:24.823: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=#
*Jul 30 15:00:24.923: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=*
*Jul 30 15:00:25.095: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=#
*Jul 30 15:00:25.175: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=1
*Jul 30 15:00:25.275: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=#
*Jul 30 15:00:25.275: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/ds_do_dial:
Digits To Dial=#
*Jul 30 15:00:25.475: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/act_setup_pend_dial_comp:
*Jul 30 15:00:25.547: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/act_setup_pend_release_ind:
Cause Value=17
*Jul 30 15:00:25.547: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/vtsp_ring_noan_timer_stop:
Timer Stop Time=249878
*Jul 30 15:00:25.547: //22/FFAE38E18033/CCAPI/cc_api_call_disconnected:
Cause Value=17, Interface=0x486FC830, Call Id=22
*Jul 30 15:00:25.547: //22/FFAE38E18033/CCAPI/cc_api_call_disconnected:
Call Entry(Responsed=TRUE, Cause Value=17, Retry Count=0)
*Jul 30 15:00:25.547: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/vtsp_set_release_source:
Release Direction=PSTN, Release Source=Called Party-PSTN
*Jul 30 15:00:25.547: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/act_setup_pend_release_ind:
Peer=102
*Jul 30 15:00:25.551: //21/xxxxxxxxxxxx/CCAPI/ccCallReleaseResources:
release reserved xcoding resource.
*Jul 30 15:00:25.551: //22/FFAE38E18033/CCAPI/ccCallSetAAA_Accounting:
Accounting=0, Call Id=22
*Jul 30 15:00:25.551: //22/FFAE38E18033/CCAPI/ccCallDisconnect:
Cause Value=17, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=17)
*Jul 30 15:00:25.551: //22/FFAE38E18033/CCAPI/ccCallDisconnect:
Cause Value=17, Call Entry(Responsed=TRUE, Cause Value=17)
*Jul 30 15:00:25.551: //22/FFAE38E18033/CCAPI/cc_api_get_transfer_info:
Transfer Number Is Null
*Jul 30 15:00:25.551: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/act_host_disc_cleanup:
dsm_indicate_error=0, short_cleardown_timeout=0, Mode=0
*Jul 30 15:00:25.551: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/act_host_disc_cleanup:
Exit State=16
*Jul 30 15:00:25.551: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/act_dsm_dsp_stats_complete:
*Jul 30 15:00:25.551: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/vtsp_timer:
Timer Start Time=249878, Timer Value=60000(ms)
*Jul 30 15:00:25.551: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/act_wrelease_release:
*Jul 30 15:00:25.551: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/vtsp_play_busy_timer_stop:
Timer Stop Time=249878
*Jul 30 15:00:25.551: //22/FFAE38E18033/VTSP0/2/0:1):-1:1:2/vtsp_timer_stop:
Timer Stop Time=249878
*Jul 30 15:00:25.555: //22/FFAE38E18033/VTSP0/2/0:1):-1:-1:-1/act_terminate:
*Jul 30 15:00:25.555: //22/FFAE38E18033/VTSP0/2/0:1):-1:-1:-1/vtsp_timer_stop:
Timer Stop Time=249879
*Jul 30 15:00:25.555: //22/FFAE38E18033/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x486FC830, Tag=0x0, Call Id=22,
Call Entry(Disconnect Cause=17, Voice Class Cause Code=0, Retry Count=0)
*Jul 30 15:00:25.555: //22/FFAE38E18033/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
*Jul 30 15:00:25.555: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Jul 30 15:00:25.555: :cc_free_feature_vsa freeing 47A4D0F0
*Jul 30 15:00:25.555: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Jul 30 15:00:25.555: vsacount in free is 1
*Jul 30 15:00:25.555: //-1/FFAE38E18033/VTSP0/2/0:1):-1:-1:-1/vtsp_free_cdb:
CDB=0x46B24F40
*Jul 30 15:00:25.555: //21/FFAE38E18033/CCAPI/ccCallDisconnect:
Cause Value=17, Tag=0x0, Call Entry(Previous Disconnect Cause=0, Disconnect Cause=0)
*Jul 30 15:00:25.555: //21/FFAE38E18033/CCAPI/ccCallDisconnect:
Cause Value=17, Call Entry(Responsed=TRUE, Cause Value=17)
*Jul 30 15:00:25.555: //21/FFAE38E18033/CCAPI/cc_api_get_transfer_info:
Transfer Number Is Null
*Jul 30 15:00:25.555: //21/FFAE38E18033/VTSP0/1/3):-1:1:1/act_pre_con_disconnect:
Cause Value=17, Hairpin=FALSE
*Jul 30 15:00:25.555: //21/FFAE38E18033/VTSP0/1/3):-1:1:1/vtsp_timer_stop:
Timer Stop Time=249879
*Jul 30 15:00:25.559: //21/FFAE38E18033/VTSP0/1/3):-1:1:1/vtsp_ring_noan_timer_stop:
Timer Stop Time=249879
*Jul 30 15:00:25.559: //21/FFAE38E18033/VTSP0/1/3):-1:1:1/vtsp_timer_stop:
Timer Stop Time=249879
*Jul 30 15:00:25.559: //21/FFAE38E18033/CCAPI/cc_api_call_disc_cause_update:
Cause Value=16
*Jul 30 15:00:25.559: //21/FFAE38E18033/CCAPI/cc_api_call_disc_cause_update:
Call Entry(Disconnect Cause=16)
*Jul 30 15:00:25.559: //21/FFAE38E18033/VTSP0/1/3):-1:1:1/vtsp_play_busy_timer_start:
Timer Start Time=249879, Busy Timer Value=30(ms)
*Jul 30 15:00:25.559: //21/FFAE38E18033/VTSP0/1/3):-1:1:1/act_pre_con_disconnect:
Tone=Busy, Tone Timeout=30(s), Progress Indication Sent=0
*Jul 30 15:00:29.255: //21/FFAE38E18033/VTSP0/1/3):-1:1:1/act_pre_con_disc_rel:
*Jul 30 15:00:29.255: //21/FFAE38E18033/VTSP0/1/3):-1:1:1/act_pre_con_disc_rel:
Cause Value=16
*Jul 30 15:00:29.255: //21/FFAE38E18033/VTSP0/1/3):-1:1:1/act_wrelease_release:
*Jul 30 15:00:29.255: //21/FFAE38E18033/VTSP0/1/3):-1:1:1/vtsp_play_busy_timer_stop:
Timer Stop Time=250249
*Jul 30 15:00:29.255: //21/FFAE38E18033/VTSP0/1/3):-1:1:1/vtsp_timer_stop:
Timer Stop Time=250249
*Jul 30 15:00:29.255: //21/FFAE38E18033/VTSP0/1/3):-1:-1:-1/act_terminate:
*Jul 30 15:00:29.255: //21/FFAE38E18033/VTSP0/1/3):-1:-1:-1/vtsp_timer_stop:
Timer Stop Time=250249
*Jul 30 15:00:29.255: //21/FFAE38E18033/CCAPI/cc_api_call_disconnect_done:
Disposition=0, Interface=0x482E9CFC, Tag=0x0, Call Id=21,
Call Entry(Disconnect Cause=16, Voice Class Cause Code=0, Retry Count=0)
*Jul 30 15:00:29.255: //21/FFAE38E18033/CCAPI/cc_api_call_disconnect_done:
Call Disconnect Event Sent
*Jul 30 15:00:29.255: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Jul 30 15:00:29.255: :cc_free_feature_vsa freeing 47A4D1C8
*Jul 30 15:00:29.255: //-1/xxxxxxxxxxxx/CCAPI/cc_free_feature_vsa:

*Jul 30 15:00:29.255: vsacount in free is 0
*Jul 30 15:00:29.255: //-1/FFAE38E18033/VTSP0/1/3):-1:-1:-1/vtsp_free_cdb:
CDB=0x46B25200
*Jul 30 15:03:29.259: //-1/xxxxxxxxxxxx/CCAPI/ccAppShutdownMode:
ccAppShutdownMode: remove it from the queue

Sorry for the long LOG.

Doing a show voice port summary during a call attempt i get:

0/2/0:1 04 r2-digital up dorm idle idle y
0/2/0:1 05 r2-digital up up seizeack idle y
0/2/0:1 06 r2-digital up dorm idle idle y

But it drops instantly.

The Provider says it doesn't receive any signal on his side.

Any ideas?

Thanks

 

[whykap]

You are trying to go out port 0/2/0:1 which according to you is an inbound only channel. Change your outbound dial-peers to use ds0-group2

And by the way this is not a PRI. This is a CAS T1 with individual DS0 channels.

 

[FranciscoS]

Thanks for the clarification.

Actually, port 0/2/0:1 is the outbound port.

 

[whykap]

Oh I see that now. You said the provider is receiving on 1-15 which will be your outbound ports.
What does dial-peer 102 look like?
What model router? IOS version?

 

[FranciscoS]

dial-peer voice 102 pots
preference 1
destination-pattern 2........
incoming called-number .
direct-inward-dial
port 0/2/0:1
prefix 2


On a Cisco 2821 Router with c2800nm-advipservicesk9-mz.124-11.XW10. I've tried with c2800nm-spservicesk9-mz.124-24.T3 but changed because it is working ok with 124-11.XW10 on another customer. In this case it's not working with both.