Solved: E1 R2 Telmex in Mexico

Guillaume Menu · ‎01-18-2012

Hello,

I am struggling to setup an E1 R2 connection from Telmex in Mexico on a 2921 CME router. I have already tried the config found on cisco.com as well as many variant I found on several forums/web site.

This E1 is a new connection in a new location --> it was never used before so I'm not able to say for sure it is working correctely (eventhought Telco said it is)

Hereafter is what I configured (please note that it is supposed to be a 10 channls E1):

controller E1 0/0/0

framing NO-CRC4

line-termination 75-ohm

ds0-group 1 timeslots 1-10 type r2-digital r2-compelled ani

cas-custom 1

country telmex

category 2

answer-signal group-b 1

groupa-callerid-end

voice-port 0/0/0:1

cptone MX

dial-peer voice 1 pots

description --- Inbound Calls

incoming called-number .

direct-inward-dial

!

dial-peer voice 940 pots

description --- Outbound- Local&National Mobile Calls

destination-pattern 904[45]T

forward-digits all

!

dial-peer voice 900 pots

description --- Outbound Telmex - Local Calls 8 digit

destination-pattern 9[1-9].......$

forward-digits all

!

dial-peer voice 9 pots

description --- Outbound Telmex - Intl

destination-pattern 9T

forward-digits all

I'm not able to get incoming calls as well as outgoing calls. The destination phoines don't even ring

From your experiences, did it happened to you already? Shall I insist on the Telco to doublecheck? What could be the missing part?

What I understood from the telco guy is the following:

They want the CME to send A2 before sending the digit to clear the channel. Since it is not doing it, an interdigit timeout is happeneing on their side before all the digit are sent by the CME.

But I'm not 100% sure of this interpretation??!?

Hereafter are some debug for an outgoing calls from extension 1710:

*Jan 17 21:22:39.031: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_process_event:

[state:S_DIGIT_COLLECT, event:E_CC_PROCEEDING]

*Jan 17 21:22:39.031: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/act_dcollect_proc:

*Jan 17 21:22:39.031: //-1/xxxxxxxxxxxx/VTSP:(0/0/0:1):-1:-1:-1/vtsp_process_event:

[state:INVALID STATE MACHINE, event:E_CC_SETUP_REQ]

*Jan 17 21:22:39.031: //6/34E06DD18012/VTSP:(0/0/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

*Jan 17 21:22:39.031: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_SETUP_REQ_PEND, event:E_VTSP_DSM_OPEN_SUCCESS]

*Jan 17 21:22:39.031: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/act_setup_req_pend_succ:

*Jan 17 21:22:39.031: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_request_call:

Mode=0, Peer=900

*Jan 17 21:22:39.031: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_request_call:

Progress Indication=3, Info Trans Capability=0

Calling Number=1710, TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed

Called Number=21225500, TON=Unknown, NPI=Unknown

*Jan 17 21:22:39.319: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_SETUP_REQUEST, event:E_TSP_PROCEEDING]

*Jan 17 21:22:39.319: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/act_setup_pend_proceeding:

*Jan 17 21:22:39.319: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_timer:

Timer Start Time=123253, Timer Value=25000(ms)

*Jan 17 21:22:39.319: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/act_setup_pend_proceeding:

Peer=900, Progress Indication=0, Return Code=2

*Jan 17 21:22:39.319: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_NULL, event:E_TSP_R2_DIAL]

*Jan 17 21:22:39.319: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/act_setup_req_pend_defer:

Event=19

*Jan 17 21:22:39.319: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_NULL, event:E_TSP_R2_DIAL]

*Jan 17 21:22:39.319: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/act_setup_req_pend_defer:

Event=19

*Jan 17 21:22:39.319: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_NULL, event:E_VTSP_DSM_OPEN_SUCCESS]

*Jan 17 21:22:39.319: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/act_setup_req_wait_pend_success:

Event=75

*Jan 17 21:22:39.319: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_timer_stop:

Timer Stop Time=123253

*Jan 17 21:22:39.319: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/act_setup_r2_pend_dial:

Digits=#, Tone Mode=1

*Jan 17 21:22:39.319: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/ds_do_dial:

Digits To Dial=#

*Jan 17 21:22:39.319: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/ds_do_dial:

Digits To Dial=2

*Jan 17 21:22:39.519: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING, event:E_VTSP_DSM_DIALING_COMPLETE]

*Jan 17 21:22:39.623: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DIGIT_BEGIN]

*Jan 17 21:22:39.623: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_TSP_R2_DIAL]

*Jan 17 21:22:39.623: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/ds_do_dial:

Digits To Dial=#

*Jan 17 21:22:49.519: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DSM_DIALING_COMPLETE]

*Jan 17 21:22:49.591: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DIGIT_END]

*Jan 17 21:22:49.591: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_TSP_R2_DIAL]

*Jan 17 21:22:49.591: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/ds_do_dial:

Digits To Dial=1

*Jan 17 21:22:49.711: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DSM_DIALING_COMPLETE]

*Jan 17 21:22:49.823: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DIGIT_BEGIN]

*Jan 17 21:22:49.823: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_TSP_R2_DIAL]

*Jan 17 21:22:49.823: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/ds_do_dial:

Digits To Dial=#

*Jan 17 21:22:59.711: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DSM_DIALING_COMPLETE]

*Jan 17 21:22:59.791: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DIGIT_END]

*Jan 17 21:22:59.791: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_TSP_R2_DIAL]

*Jan 17 21:22:59.791: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/ds_do_dial:

Digits To Dial=2

*Jan 17 21:22:59.911: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DSM_DIALING_COMPLETE]

*Jan 17 21:23:00.019: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DIGIT_BEGIN]

*Jan 17 21:23:00.019: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_TSP_R2_DIAL]

*Jan 17 21:23:00.019: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/ds_do_dial:

Digits To Dial=#

*Jan 17 21:23:09.911: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DSM_DIALING_COMPLETE]

*Jan 17 21:23:09.991: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DIGIT_END]

*Jan 17 21:23:09.991: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_TSP_R2_DIAL]

*Jan 17 21:23:09.991: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/ds_do_dial:

Digits To Dial=2

*Jan 17 21:23:10.111: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DSM_DIALING_COMPLETE]

*Jan 17 21:23:10.231: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DIGIT_BEGIN]

*Jan 17 21:23:10.231: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_TSP_R2_DIAL]

*Jan 17 21:23:10.231: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/ds_do_dial:

Digits To Dial=#

*Jan 17 21:23:20.111: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DSM_DIALING_COMPLETE]

*Jan 17 21:23:20.183: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DIGIT_END]

*Jan 17 21:23:20.183: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_TSP_R2_DIAL]

*Jan 17 21:23:20.183: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/ds_do_dial:

Digits To Dial=5

*Jan 17 21:23:20.311: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DSM_DIALING_COMPLETE]

*Jan 17 21:23:20.411: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_VTSP_DIGIT_BEGIN]

*Jan 17 21:23:20.411: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_TSP_R2_DIAL]

*Jan 17 21:23:20.411: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/ds_do_dial:

Digits To Dial=#

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_process_event:

[state:S_PROCEEDING, event:E_TSP_DISCONNECT_IND]

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/act_generate_disc:

Cause Value=16

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_timer_stop:

Timer Stop Time=128235

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_ring_noan_timer_stop:

Timer Stop Time=128235

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_set_release_source:

Release Direction=PSTN, Release Source=Calling Party-PSTN

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_timer:

Timer Start Time=128235, Timer Value=15000(ms)

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/act_generate_disc:

Return Code=0

*Jan 17 21:23:29.139: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_DIALING_COMP, event:E_CC_DISCONNECT]

*Jan 17 21:23:29.139: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/ds_dialing_release:

*Jan 17 21:23:29.139: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/ds_dial_event_check:

*Jan 17 21:23:29.139: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/act_setup_pend_dial_comp:

*Jan 17 21:23:29.139: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/act_disconnect:

Cause Value=16

*Jan 17 21:23:29.139: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_ring_noan_timer_stop:

Timer Stop Time=128235

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_process_event:

[state:S_WAIT_HOST_DISC, event:E_CC_DISCONNECT]

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/act_host_disc_cleanup:

dsm_indicate_error=0, short_cleardown_timeout=1, Mode=0

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_dsm_save_fax_config:

Call Entry=NULL, Call Id=-1

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/act_host_disc_cleanup:

Exit State=16

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_process_event:

[state:S_WAIT_STATS, event:E_VTSP_DSM_STATS_COMPLETE]

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/act_dsm_dsp_stats_complete:

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_timer:

Timer Start Time=128235, Timer Value=60000(ms)

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_process_event:

[state:S_WAIT_RELEASE, event:E_VTSP_DSM_STATS_COMPLETE]

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_process_event:

Unexpected EVENT [E_VTSP_DSM_STATS_COMPLETE] Received For STATE [S_WAIT_RELEASE];

Previous STATE [0.16 ]

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_process_event:

[state:S_WAIT_RELEASE, event:E_TSP_DISCONNECT_CONF]

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/act_wrelease_release:

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_play_busy_timer_stop:

Timer Stop Time=128235

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_timer_stop:

Timer Stop Time=128235

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:0:1/vtsp_is_valid_dsm_handle:

DMGR=0x31A08A2C, VTSP CDB=0x3000FA80

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:-1:-1/vtsp_process_event:

[state:S_CLOSE_DSPRM, event:E_VTSP_DSM_CLOSE_COMPLETE]

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:-1:-1/act_terminate:

*Jan 17 21:23:29.139: //5/34E06DD18012/VTSP:(50/0/1):-1:-1:-1/vtsp_timer_stop:

Timer Stop Time=128235

*Jan 17 21:23:29.139: //-1/34E06DD18012/VTSP:(50/0/1):-1:-1:-1/vtsp_free_cdb:

CDB=0x3000FA80

*Jan 17 21:23:30.311: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_WAIT_STATS, event:E_VTSP_DSM_DIALING_COMPLETE]

*Jan 17 21:23:30.311: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

Unexpected EVENT [E_VTSP_DSM_DIALING_COMPLETE] Received For STATE [S_WAIT_STATS];

Previous STATE [0.11 ]

*Jan 17 21:23:30.391: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_WAIT_STATS, event:E_VTSP_DIGIT_END]

*Jan 17 21:23:30.391: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

Unexpected EVENT [E_VTSP_DIGIT_END] Received For STATE [S_WAIT_STATS];

Previous STATE [0.11 ]

*Jan 17 21:23:30.511: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_WAIT_STATS, event:E_VTSP_DSM_DIALING_COMPLETE]

*Jan 17 21:23:30.511: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

Unexpected EVENT [E_VTSP_DSM_DIALING_COMPLETE] Received For STATE [S_WAIT_STATS];

Previous STATE [0.11 ]

*Jan 17 21:23:30.511: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_WAIT_STATS, event:E_VTSP_DSM_STATS_COMPLETE]

*Jan 17 21:23:30.511: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/act_dsm_dsp_stats_complete:

*Jan 17 21:23:30.511: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_timer:

Timer Start Time=128372, Timer Value=60000(ms)

*Jan 17 21:23:30.511: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_WAIT_RELEASE, event:E_VTSP_DSM_STATS_COMPLETE]

*Jan 17 21:23:30.511: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

Unexpected EVENT [E_VTSP_DSM_STATS_COMPLETE] Received For STATE [S_WAIT_RELEASE];

Previous STATE [0.16 ]

*Jan 17 21:23:30.595: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_WAIT_RELEASE, event:E_TSP_DISCONNECT_CONF]

*Jan 17 21:23:30.595: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/act_wrelease_release:

*Jan 17 21:23:30.595: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_play_busy_timer_stop:

Timer Stop Time=128381

*Jan 17 21:23:30.595: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_timer_stop:

Timer Stop Time=128381

*Jan 17 21:23:30.595: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_is_valid_dsm_handle:

DMGR=0x300438F4, VTSP CDB=0x3000F7B8

*Jan 17 21:23:30.595: //6/34E06DD18012/VTSP:(0/0/0:1):-1:-1:-1/vtsp_process_event:

[state:S_CLOSE_DSPRM, event:E_VTSP_DSM_CLOSE_COMPLETE]

*Jan 17 21:23:30.595: //6/34E06DD18012/VTSP:(0/0/0:1):-1:-1:-1/act_terminate:

*Jan 17 21:23:30.595: //6/34E06DD18012/VTSP:(0/0/0:1):-1:-1:-1/vtsp_timer_stop:

Timer Stop Time=128381

*Jan 17 21:23:30.599: //-1/34E06DD18012/VTSP:(0/0/0:1):-1:-1:-1/vtsp_free_cdb:

CDB=0x3000F7B8

*Jan 17 21:23:45.611: //-1/xxxxxxxxxxxx/VTSP:(0/0/0:1):-1:-1:-1/vtsp_allocate_cdb:

CDB=0x3000FD48

*Jan 17 21:23:45.611: //-1/xxxxxxxxxxxx/VTSP:(0/0/0:1):-1:-1:-1/vtsp_do_call_setup_ind:

Event=E_TSP_R2_START_DIGIT

Progress Indication=0, CarrierIDCode=, Info Trans Capability=0, Source Carrier ID=, tg_label_flag=0

*Jan 17 21:23:45.611: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:-1:-1/vtsp_insert_cdb:

*Jan 17 21:23:45.611: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:-1:-1/vtsp_do_call_setup_ind:

Redirect Number=, Redirect Reason=0

*Jan 17 21:23:45.611: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_PENDING, event:E_VTSP_DSM_OPEN_SUCCESS]

*Jan 17 21:23:45.791: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_COLLECT, event:E_VTSP_DIGIT_BEGIN]

*Jan 17 21:23:45.791: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_COLLECT, event:E_TSP_R2_DIAL]

*Jan 17 21:23:45.791: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/ds_do_dial:

Digits To Dial=1

*Jan 17 21:23:45.883: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_COLLECT, event:E_VTSP_DIGIT_END]

*Jan 17 21:23:45.883: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_COLLECT, event:E_TSP_R2_DIAL]

*Jan 17 21:23:45.883: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/ds_do_dial:

Digits To Dial=#

*Jan 17 21:23:48.791: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_COLLECT, event:E_TSP_R2_DIAL]

*Jan 17 21:23:48.791: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/ds_do_dial:

Digits To Dial=#

*Jan 17 21:23:48.791: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_COLLECT, event:E_TSP_R2_DIAL]

*Jan 17 21:23:48.791: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/ds_do_dial:

Digits To Dial=4#

*Jan 17 21:23:48.791: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_COLLECT, event:E_TSP_DISCONNECT_IND]

*Jan 17 21:23:55.791: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_WAIT_RELEASE, event:E_VTSP_DSM_DIALING_COMPLETE]

*Jan 17 21:23:55.863: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_WAIT_RELEASE, event:E_VTSP_DIGIT_BEGIN]

*Jan 17 21:23:55.983: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_WAIT_RELEASE, event:E_VTSP_DSM_DIALING_COMPLETE]

*Jan 17 21:23:56.183: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_WAIT_RELEASE, event:E_VTSP_DSM_DIALING_COMPLETE]

*Jan 17 21:23:56.283: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_WAIT_RELEASE, event:E_VTSP_DIGIT_END]

*Jan 17 21:23:56.563: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_WAIT_RELEASE, event:E_VTSP_DSM_DIALING_COMPLETE]

*Jan 17 21:23:58.675: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:1:1/vtsp_process_event:

[state:S_R2_WAIT_RELEASE, event:E_TSP_DISCONNECT_CONF]

*Jan 17 21:23:58.675: //-1/5F4823EB8017/VTSP:(0/0/0:1):-1:-1:-1/vtsp_process_event:

[state:S_R2_WAIT_CLOSE, event:E_VTSP_DSM_CLOSE_COMPLETE]

*Jan 17 21:23:58.675: //-1/5F4823EB8017/VTSP:():-1:-1:-1/vtsp_free_cdb:

CDB=0x3000FD48

paolo bevilacqua · ‎01-18-2012

I was to suggest 15.1(4)M3 but likely won't make any difference.

I was trying to see where the router sends A2, but could not see that. So probably telco is right.

View solution in original post

Leonardo Santana · ‎01-18-2012

Hello take a look on this docs:

http://www.cisco.com/en/US/tech/tk652/tk653/technologies_tech_note09186a00800943c2.shtml

http://www.cisco.com/en/US/tech/tk652/tk653/technologies_configuration_example09186a00800ad389.shtml

Regards

Regards
Leonardo Santana

*** Rate All Helpful Responses***

Guillaume Menu · ‎01-18-2012

Thx, but I already went accross all those doc and couldn't find any hint on how to proceed further.

Anyone having good or bad experiences with Telmex in Mexico??

acampbell · ‎01-18-2012

Hi,

If this is the running config none of

your outbound dial pewers are pointing at the port

Try changing to this:-

dial-peer voice 1 pots

description --- Inbound Calls

incoming called-number .

direct-inward-dial

port 0/0/0:1

!

dial-peer voice 940 pots

description --- Outbound- Local&National Mobile Calls

destination-pattern 904[45]T

forward-digits all

port 0/0/0:1

!

dial-peer voice 900 pots

description --- Outbound Telmex - Local Calls 8 digit

destination-pattern 9[1-9].......$

forward-digits all

port 0/0/0:1

!

dial-peer voice 9 pots

description --- Outbound Telmex - Intl

destination-pattern 9T

forward-digits all

port 0/0/0:1

Regards

Alex

Regards, Alex. Please rate useful posts.

Guillaume Menu · ‎01-18-2012

Hi Alex,

very good point. But of course, I had this command in the config when I tested. They were not present when I did the copy/paste because my colleague shutdown the port to try something.

But the calls are going to the ports (otherwise the debug would no show any r2 info)

acampbell · ‎01-18-2012

Hi,

Looking at your trace

Calling Number=1710, TON=Unknown, NPI=Unknown, Screening=Not Screened, Presentation=Allowed

Called Number=21225500, TON=Unknown, NPI=Unknown

Called Number=21225500 I do not see which dial peer this is supposed to match,

all your outbound peers seem to start with 9

Regards

Alex

Regards, Alex. Please rate useful posts.

Guillaume Menu · ‎01-18-2012

There is a translation-rule as well that I didn't copy/paste in the config to remove the 9.

The dial-peer hitted is dial-peer 900, from the trace:

*Jan 17 21:22:39.031: //6/34E06DD18012/VTSP:(0/0/0:1):-1:1:1/vtsp_request_call:

Mode=0, Peer=900

The call are going to the E1 port, it is not a dial-peer issue, it is an E1 R2 issue.

If I'm trying an incoming call, same pb, it doesn't go further than the E1 (debug voip ccapi inout don't even show a line)

acampbell · ‎01-18-2012

Hi,

From this link

http://www.cisco.com/en/US/docs/ios/11_3/feature/guide/r2voip.html#wp3913

country name use-defaults

Specifies the local country, regional, and some corporation settings for R2 signaling. Replace the name variable with one of the following supported country names. Cisco strongly recommends that you include the use-defaults option, which enables the default settings for a specific country. Default country setting is ITU.

You may need to change your CAS config to:-

cas-custom 1
country telmex use-defaults

Regards
Alex

Regards, Alex. Please rate useful posts.

Guillaume Menu · ‎01-18-2012

Well according to cisco doc and other config I've seen, the Telmex config is very specific and need the other parameters as well.

Source:

http://www.cisco.com/en/US/tech/tk652/tk653/technologies_tech_note09186a008024903b.shtml#mexico

Mexico Telmex Modified

controller E1 0/0
 framing NO-CRC4
 ds0-group 1 timeslots 1-15,17-30 type r2-digital r2-compelled ani
 cas-custom 1
  country telmex
  category 2
  answer-signal group-b 1

Note: In some implementations, Telmex requires that Group A signals be used for automatic number identification (ANI) collection. If this is needed, add the command groupa-callerid-end under cas-custom. If this command is not configured, the router uses the country default (a Group C signal).

paolo bevilacqua · ‎01-18-2012

Which exact IOS are you running ?

Guillaume Menu · ‎01-18-2012

15.1(1)T3

paolo bevilacqua · ‎01-18-2012

I was to suggest 15.1(4)M3 but likely won't make any difference.

I was trying to see where the router sends A2, but could not see that. So probably telco is right.

Guillaume Menu · ‎01-20-2012

Hi Paolo,

likely not, but in reality it makes all the difference.... 15.1(1)T doesn't work, 15.1(4)M3 works like a charm wirh default telme config!

My issue is that I can't use CME 8.6 but rather lower version.

Does anyone have experience with the following IOS and E1 R2 in mexico from Telmex? Like:

- 15.0(1)M CME 7.1 which is the recommended cisco version BTW

- 15.1(2)T CME 8.1

- 15.1(3)T CME 8.5

Thx in advance

G

paolo bevilacqua · ‎01-20-2012

Unfortunatly, E1 R2 code is quite shaky across versions.

For this reason, I would not change it not matter what when it works.

Thanks for the nice rating and good luck!