Buy or Renew
Buy or Renew
Cisco + Splunk: It’s a new day for your data. Learn more.
 
cancel
Turn on suggestions
Auto-suggest helps you quickly narrow down your search results by suggesting possible matches as you type.
Showing results for 
Search instead for 
Did you mean: 
cancel
Start a conversation
1778
Views
0
Helpful
4
Replies

Outgoing Calls via E1 - R2 digital don't work

Rodrigo Rosa da Silva
Level 1
Level 1

‎04-17-2014 07:41 PM - edited ‎03-16-2019 10:30 PM

Hi all,

 

I have a problem with a circuit (R2 digital). Incoming calls work normally but outgoing calls don't work.

 

Configurations:

 

network-clock-participate wic 0 
network-clock-participate wic 1 
network-clock-select 1 E1 0/1/1
network-clock-select 2 E1 0/0/0

!

voice service pots
!         
voice service voip
 allow-connections h323 to h323
 supplementary-service h450.12
 fax protocol t38 version 0 ls-redundancy 0 hs-redundancy 0 fallback none
 h323     
 modem passthrough nse codec g711ulaw

!

controller E1 0/0/0
 framing NO-CRC4 
 ds0-group 0 timeslots 1-15,17-31 type r2-digital r2-compelled ani
 cas-custom 0
  country brazil
  metering
  seizure-ack-time 50
  release-ack
  double-answer
  category 2
  answer-signal group-b 1

!

voice-port 0/0/0:0
 translation-profile incoming prefixo-unidades
 cptone BR
 timeouts call-disconnect 3
 bearer-cap Speech

!

dial-peer voice 23000 pots
 destination-pattern [2-5].......
 no digit-strip
 port 0/0/0:0

!

dial-peer voice 1010000 voip
 destination-pattern 101....
 session target ipv4:10.1.64.21
 dtmf-relay cisco-rtp
 ip qos dscp cs5 media
 no vad

 

Debug vpm signal

 

*Apr 18 02:01:39.483: htsp_timer_stop3 htsp_setup_req
*Apr 18 02:01:39.487:  Orig called num:32413393
*Apr 18 02:01:39.487:  Orig called num:32413393
*Apr 18 02:01:39.487: htsp_process_event: [0/0/0:0(5), R2_Q421_IDLE, E_HTSP_SETUP_REQ]
*Apr 18 02:01:39.487: r2_q421_seize(0/0/0:0(5)) E_HTSP_SETUP_REQ DNIS=32413393 ANI=1017080
*Apr 18 02:01:39.487: r2_q421_seize(0/0/0:0(5)) Tx SEIZUREvnm_dsp_set_sig_state:[R2 Q.421 0/0/0:0(5)] set signal state = 0x0
*Apr 18 02:01:39.487: htsp_timer - 5000 msec
*Apr 18 02:01:44.487: htsp_process_event: [0/0/0:0(5), R2_Q421_OG_SEIZE, E_HTSP_EVENT_TIMER]
*Apr 18 02:01:44.487: r2_q421_seize_to(0/0/0:0(5)) Tx CLEAR FWDvnm_dsp_set_sig_state:[R2 Q.421 0/0/0:0(5)] set signal state = 0x8
*Apr 18 02:01:44.487: htsp_timer - 1000 msec
*Apr 18 02:01:44.487: r2_reg_channel_disconnected(0/0/0:0(5))
*Apr 18 02:01:44.487: r2_reg_process_event: [0/0/0:0(5), R2_REG_IDLE, E_R2_REG_DISCONNECT(91)] 
*Apr 18 02:01:44.487: r2_reg_disconnect_idle(0/0/0:0(5))
*Apr 18 02:01:44.487: r2_reg_timer_stop(0/0/0:0(5))
*Apr 18 02:01:45.487: htsp_process_event: [0/0/0:0(5), R2_Q421_OG_CLR_FWD, E_HTSP_EVENT_TIMER]
*Apr 18 02:01:45.487: r2_q421_clr_fwd_to(0/0/0:0(5))
*Apr 18 02:01:45.487: htsp_timer - 2000 msec
*Apr 18 02:01:47.487: htsp_process_event: [0/0/0:0(5), R2_Q421_WAIT_IDLE, E_HTSP_EVENT_TIMER]
*Apr 18 02:01:47.487: r2_q421_wait_idle_to(0/0/0:0(5)) Tx IDLEvnm_dsp_set_sig_state:[R2 Q.421 0/0/0:0(5)] set signal state = 0x8
*Apr 18 02:01:47.487: htsp_timer - 2000 msec
*Apr 18 02:01:47.487: htsp_process_event: [0/0/0:0(5), R2_Q421_WAIT_IDLE, E_DSP_SIG_1000]
*Apr 18 02:01:47.487: r2_q421_wait_idle(0/0/0:0(5)) Rx IDLE
*Apr 18 02:01:47.487: r2_reg_channel_disconnected(0/0/0:0(5))
*Apr 18 02:01:47.487: htsp_timer_stop 
*Apr 18 02:01:47.487: r2_reg_process_event: [0/0/0:0(5), R2_REG_IDLE, E_R2_REG_DISCONNECT(91)] 
*Apr 18 02:01:47.487: r2_reg_disconnect_idle(0/0/0:0(5))
*Apr 18 02:01:47.487: r2_reg_timer_stop(0/0/0:0(5))
*Apr 18 02:01:47.487: htsp_process_event: [0/0/0:0(5), R2_Q421_IDLE, E_HTSP_RELEASE_REQ]
*Apr 18 02:01:47.487: r2_q421_idle_release(0/0/0:0(5)) E_HTSP_RELEASE_REQ
*Apr 18 02:01:47.487: r2_q421_idle_release(0/0/0:0(5)) Tx IDLEvnm_dsp_set_sig_state:[R2 Q.421 0/0/0:0(5)] set signal state = 0x8
*Apr 18 02:01:47.487: htsp_timer_stop 
*Apr 18 02:01:47.487: r2_reg_channel_disconnected(0/0/0:0(5))
*Apr 18 02:01:47.491: r2_reg_process_event: [0/0/0:0(5), R2_REG_IDLE, E_R2_REG_DISCONNECT(91)] 
*Apr 18 02:01:47.491: r2_reg_disconnect_idle(0/0/0:0(5))
*Apr 18 02:01:47.491: r2_reg_timer_stop(0/0/0:0(5))

 

Debug vtsp all

 

*Apr 18 02:02:33.823: //-1/xxxxxxxxxxxx/VTSP:(0/0/0:0):-1:-1:-1/vtsp_allocate_cdb:  
   CDB=0x23396600
*Apr 18 02:02:33.823: //-1/xxxxxxxxxxxx/VTSP:(0/0/0:0):-1:-1:-1/vtsp_insert_cdb: 
*Apr 18 02:02:33.823: //-1/xxxxxxxxxxxx/VTSP:(0/0/0:0):-1:-1:-1/vtsp_process_event:  
   [state:INVALID STATE MACHINE, event:E_CC_SETUP_REQ]
*Apr 18 02:02:33.823: //66/80CCD0AD1800/VTSP:(0/0/0:0):-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
*Apr 18 02:02:33.823: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:-1:-1/vtsp_do_call_setup_req: 
*Apr 18 02:02:33.827: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_dsm_opened_cb: 
*Apr 18 02:02:33.827: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_process_event:  
   [state:S_SETUP_REQ_PEND, event:E_VTSP_DSM_OPEN_SUCCESS]
*Apr 18 02:02:33.827: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/act_setup_req_pend_succ: 
*Apr 18 02:02:33.827: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_request_call:  
   Mode=0, Peer=23000
*Apr 18 02:02:33.827: digit_strip:0, pcn:32413393, poa:[2-5].......
*Apr 18 02:02:33.827: Final pcn:32413393, poa:[2-5]......., dial_string:32413393
*Apr 18 02:02:33.827: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_create_call_active_on_setup_req:  
   Target Carrier ID=
*Apr 18 02:02:33.827: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_create_call_active_on_setup_req:  
   Source Carrier ID=
*Apr 18 02:02:33.827: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_request_call:  
   Progress Indication=0, Info Trans Capability=128
   Calling Number=1017080, TON=Unknown, NPI=Unknown, Screening=User, Passed, Presentation=Allowed
   Called Number=32413393, TON=Unknown, NPI=Unknown
*Apr 18 02:02:41.827: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_process_event:  
   [state:S_SETUP_REQUEST, event:E_TSP_DISCONNECT_IND]
*Apr 18 02:02:41.827: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/act_setup_pend_release_ind:  
   Cause Value=34
*Apr 18 02:02:41.827: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_ring_noan_timer_stop:  
   Timer Stop Time=165898
*Apr 18 02:02:41.827: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_cc_call_disconnected: 
*Apr 18 02:02:41.827: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_cc_call_disconnected:  
   Cause Value=34
*Apr 18 02:02:41.827: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_set_release_source:  
   Release Direction=PSTN, Release Source=Called Party-PSTN
*Apr 18 02:02:41.827: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/act_setup_pend_release_ind:  
   Peer=23000
*Apr 18 02:02:41.831: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_call_disconnect:  
   [Out Of Service]-Tone Played In Direction [Both]
*Apr 18 02:02:41.831: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_process_event:  
   [state:S_SETUP_REQUEST, event:E_CC_DISCONNECT]
*Apr 18 02:02:41.831: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/act_disconnect_no_dsp_chan:  
   Hairpin=FALSE, Cause Value=34, Previous Cause Value=34
*Apr 18 02:02:41.831: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_do_call_history: 
*Apr 18 02:02:41.831: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_do_call_history:  
   Coder Rate=-1
*Apr 18 02:02:41.831: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/act_disconnect_no_dsp_chan:  
   Peer=23000
*Apr 18 02:02:41.831: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_process_event:  
   [state:S_SETUP_FAIL, event:E_TSP_DISCONNECT_CONF]
*Apr 18 02:02:41.831: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/act_setup_fail: 
*Apr 18 02:02:41.831: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:1:1/vtsp_timer_stop:  
   Timer Stop Time=165898
*Apr 18 02:02:41.831: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:-1:-1/vtsp_dsm_closed_cb: 
*Apr 18 02:02:41.831: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:-1:-1/vtsp_process_event:  
   [state:S_CLOSE_DSPRM, event:E_VTSP_DSM_CLOSE_COMPLETE]
*Apr 18 02:02:41.831: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:-1:-1/act_terminate: 
*Apr 18 02:02:41.831: //66/80CCD0AD1800/VTSP:(0/0/0:0):-1:-1:-1/vtsp_timer_stop:  
   Timer Stop Time=165898
*Apr 18 02:02:41.831: //-1/80CCD0AD1800/VTSP:(0/0/0:0):-1:-1:-1/vtsp_free_cdb:  
   CDB=0x23396600

 

*** When I make a outgoing call the result of (show voice port summary)

 

Router#sh voice port summary 
                                           IN       OUT
PORT            CH   SIG-TYPE   ADMIN OPER STATUS   STATUS   EC
=============== == ============ ===== ==== ======== ======== ==
0/0/0:0         01  r2-digital  up    up   clearfwd idle     y

[ ]'s

Labels:
0 Helpful
4 Replies 4

taherrer
Level 1
Level 1

‎04-18-2014 12:07 PM

Hello Rodrigo ,

What version of CUCM are you running ? , check  this bug CSCul71689 :)

Regards,

 

0 Helpful

Brian Meade
Level 7
Level 7
In response to taherrer

‎04-18-2014 01:03 PM

That bug should not be applicable here.  The debugs show the call hits the gateway.  In the case of the bug you linked, the call would never be sent from CUCM to the gateway in the first place.

0 Helpful

Brian Meade
Level 7
Level 7

‎04-18-2014 01:01 PM

It looks like the PSTN is sending a disconnect with ISDN cause code 34-no circuit/channel available.

 

It may be because you are sending on the first channel instead of the last.  I don't know of any way to change this order on a CAS circuit though unless you're using MGCP.

 

It also may be because of the calling/called number numbering type/plan of unknown you are sending.  You may need some input from the carrier why they are rejecting the calls.

0 Helpful

Rodrigo Rosa da Silva
Level 1
Level 1

‎04-20-2014 08:20 PM

Hi all,

 

We found that this circuit had a unidirectional configuration:
 
1-15 - incoming calls
17-31 - outgoing calls
 
 
We requested bidirectional configuration and then worked.
 
Now the circuit is working correctly, where all of the channels are used to incoming or outgoing calls.
 
Thanks!
0 Helpful
Getting Started

Find answers to your questions by entering keywords or phrases in the Search bar above. New here? Use these resources to familiarize yourself with the community:

Customers Also Viewed These Support Documents