Re: [asterisk-users] BT ISDN-30 Call Failures

2010-03-25 Thread Gavin Henry
Any probs with the circuits?

Try and upgrade?

On 17/03/2010, Russell Brown russ...@lls.lls.com wrote:


 I'm seeing both inbound and outgoing call failures on our ISDN-30 lines
 that only seem to go away when I do a zap restart or in extremis
 restart Asterisk (1.4.25 with a Digium TE205P and zaptel 1.4.12.1).  If
 I don't restart zapata or Asterisk the problem rapidly get worse :-(

 The lines are from BT with LCR from CableWireless (I've tried using the
 LCR bypass code and it doesn't make any difference).

 The outbound symptoms are that the number appears to go out on the ISDN
 but the caller hears nothing and the callee's phone doesn't ring
 (example below with ISDN debug on).

 The incoming problem is that the callee's phone rings for a couple of
 seconds and then the call gets cutoff (again example enclosed) or
 sometimes doesn't appear at all in the Asterisk logs and the callee gets
 a busy tone (no the system hasn't used all of the channels at this point
 :-).

 Can anyone suggest a cause and/or remedy?  Any idea what the
 disconnection stuff in the PRI debug means?



 Outbound log extract:


  [Mar 17 16:58:02] VERBOSE[6630] logger.c: -- Executing
 [01780471...@from-sip:18] Dial(SIP/197-b6726980,
 Zap/G1/01780471800||TWK) in new stack
  [Mar 17 16:58:02] VERBOSE[6630] logger.c: -- Making new call for cr 33089
  [Mar 17 16:58:02] VERBOSE[6630] logger.c: -- Requested transfer
 capability: 0x00 - SPEECH
  [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Protocol Discriminator: Q.931
 (8)  len=40
  [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Call Ref: len= 2 (reference
 321/0x141) (Originator)
  [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Message type: SETUP (5)
  [Mar 17 16:58:02] VERBOSE[6630] logger.c:  [04 03 80 90 a3]
  [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Bearer Capability (len= 5) [
 Ext: 1  Q.931 Std: 0  Info transfer capability: Speech (0)
  [Mar 17 16:58:02] VERBOSE[6630] logger.c: 
 Ext: 1  Trans mode/rate: 64kbps, circuit-mode (16)
  [Mar 17 16:58:02] VERBOSE[6630] logger.c: 
 User information layer 1: A-Law (35)
  [Mar 17 16:58:02] VERBOSE[6630] logger.c:  [18 03 a9 83 9e]
  [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Channel ID (len= 5) [ Ext: 1
 IntID: Implicit  PRI  Spare: 0  Exclusive  Dchan: 0
  [Mar 17 16:58:02] VERBOSE[6630] logger.c: ChanSel:
 As indicated in following octets
  [Mar 17 16:58:02] VERBOSE[6630] logger.c:Ext: 1
 Coding: 0  Number Specified  Channel Type: 3
  [Mar 17 16:58:02] VERBOSE[6630] logger.c:Ext: 1
 Channel: 30 ]
  [Mar 17 16:58:02] VERBOSE[6630] logger.c:  [6c 08 00 80 38 34 36 30 38 30]
  [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Calling Number (len=10) [ Ext:
 0  TON: Unknown Number Type (0)  NPI: Unknown Number Plan (0)
  [Mar 17 16:58:02] VERBOSE[6630] logger.c: 
 Presentation: Presentation permitted, user number not screened (0)  '846080'
 ]
  [Mar 17 16:58:02] VERBOSE[6630] logger.c:  [70 0c 80 30 31 37 38 30 34 37
 31 38 30 32]
  [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Called Number (len=14) [ Ext: 1
  TON: Unknown Number Type (0)  NPI: Unknown Number Plan (0)  '01780471800' ]
  [Mar 17 16:58:02] VERBOSE[6630] logger.c:  [a1]
  [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Sending Complete (len= 1)
  [Mar 17 16:58:02] VERBOSE[6630] logger.c: q931.c:3134 q931_setup: call
 33089 on channel 30 enters state 1 (Call Initiated)
  [Mar 17 16:58:02] VERBOSE[6630] logger.c: -- Called G1/01780471800
 *** At this point the caller hears nothing and the phone on
   *** 01780471800 *doesn't* receive a call.
  [Mar 17 16:58:50] VERBOSE[6630] logger.c: NEW_HANGUP DEBUG: Calling
 q931_hangup, ourstate Call Initiated, peerstate Overlap sending
  [Mar 17 16:58:50] VERBOSE[6630] logger.c: q931.c:3015 q931_disconnect: call
 33089 on channel 30 enters state 11 (Disconnect Request)
  [Mar 17 16:58:50] VERBOSE[6630] logger.c:  Protocol Discriminator: Q.931
 (8)  len=9
  [Mar 17 16:58:50] VERBOSE[6630] logger.c:  Call Ref: len= 2 (reference
 321/0x141) (Originator)
  [Mar 17 16:58:50] VERBOSE[6630] logger.c:  Message type: DISCONNECT (69)
  [Mar 17 16:58:50] VERBOSE[6630] logger.c:  [08 02 81 90]
  [Mar 17 16:58:50] VERBOSE[6630] logger.c:  Cause (len= 4) [ Ext: 1
 Coding: CCITT (ITU) standard (0)  Spare: 0  Location: Private network
 serving the local user (1)
  [Mar 17 16:58:50] VERBOSE[6630] logger.c:   Ext: 1  Cause:
 Normal Clearing (16), class = Normal Event (1) ]
  [Mar 17 16:58:50] VERBOSE[6630] logger.c: -- Hungup 'Zap/30-1'
  [Mar 17 16:58:50] VERBOSE[6630] logger.c:   == Spawn extension (from-sip,
 01780471800, 18) exited non-zero on 'SIP/197-b6726980'


 Here's an example of the inbound failure:


  [Mar 17 17:04:46] VERBOSE[13006] logger.c: -- Executing
 [846...@isdn_in:1] Ringing(Zap/20-1, ) in new stack
  [Mar 17 17:04:46] VERBOSE[13006] logger.c: q931.c:2844 q931_alerting: call
 79 on channel 20 enters state 7 (Call Received)
  [Mar 17 

[asterisk-users] BT ISDN-30 Call Failures

2010-03-17 Thread Russell Brown


I'm seeing both inbound and outgoing call failures on our ISDN-30 lines
that only seem to go away when I do a zap restart or in extremis
restart Asterisk (1.4.25 with a Digium TE205P and zaptel 1.4.12.1).  If
I don't restart zapata or Asterisk the problem rapidly get worse :-(

The lines are from BT with LCR from CableWireless (I've tried using the
LCR bypass code and it doesn't make any difference).

The outbound symptoms are that the number appears to go out on the ISDN
but the caller hears nothing and the callee's phone doesn't ring
(example below with ISDN debug on).

The incoming problem is that the callee's phone rings for a couple of
seconds and then the call gets cutoff (again example enclosed) or
sometimes doesn't appear at all in the Asterisk logs and the callee gets
a busy tone (no the system hasn't used all of the channels at this point :-).

Can anyone suggest a cause and/or remedy?  Any idea what the
disconnection stuff in the PRI debug means?



Outbound log extract:


 [Mar 17 16:58:02] VERBOSE[6630] logger.c: -- Executing 
[01780471...@from-sip:18] Dial(SIP/197-b6726980, 
Zap/G1/01780471800||TWK) in new stack
 [Mar 17 16:58:02] VERBOSE[6630] logger.c: -- Making new call for cr 33089
 [Mar 17 16:58:02] VERBOSE[6630] logger.c: -- Requested transfer 
capability: 0x00 - SPEECH
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Protocol Discriminator: Q.931 (8)  
len=40
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Call Ref: len= 2 (reference 
321/0x141) (Originator)
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Message type: SETUP (5)
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:  [04 03 80 90 a3]
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Bearer Capability (len= 5) [ Ext: 
1  Q.931 Std: 0  Info transfer capability: Speech (0)
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:   Ext: 
1  Trans mode/rate: 64kbps, circuit-mode (16)
 [Mar 17 16:58:02] VERBOSE[6630] logger.c: 
User information layer 1: A-Law (35)
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:  [18 03 a9 83 9e]
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Channel ID (len= 5) [ Ext: 1  
IntID: Implicit  PRI  Spare: 0  Exclusive  Dchan: 0
 [Mar 17 16:58:02] VERBOSE[6630] logger.c: ChanSel: As 
indicated in following octets
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:Ext: 1  
Coding: 0  Number Specified  Channel Type: 3
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:Ext: 1  
Channel: 30 ]
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:  [6c 08 00 80 38 34 36 30 38 30]
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Calling Number (len=10) [ Ext: 0  
TON: Unknown Number Type (0)  NPI: Unknown Number Plan (0)
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:
Presentation: Presentation permitted, user number not screened (0)  '846080' ]
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:  [70 0c 80 30 31 37 38 30 34 37 31 
38 30 32]
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Called Number (len=14) [ Ext: 1  
TON: Unknown Number Type (0)  NPI: Unknown Number Plan (0)  '01780471800' ]
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:  [a1]
 [Mar 17 16:58:02] VERBOSE[6630] logger.c:  Sending Complete (len= 1)
 [Mar 17 16:58:02] VERBOSE[6630] logger.c: q931.c:3134 q931_setup: call 33089 
on channel 30 enters state 1 (Call Initiated)
 [Mar 17 16:58:02] VERBOSE[6630] logger.c: -- Called G1/01780471800
*** At this point the caller hears nothing and the phone on
*** 01780471800 *doesn't* receive a call.
 [Mar 17 16:58:50] VERBOSE[6630] logger.c: NEW_HANGUP DEBUG: Calling 
q931_hangup, ourstate Call Initiated, peerstate Overlap sending
 [Mar 17 16:58:50] VERBOSE[6630] logger.c: q931.c:3015 q931_disconnect: call 
33089 on channel 30 enters state 11 (Disconnect Request)
 [Mar 17 16:58:50] VERBOSE[6630] logger.c:  Protocol Discriminator: Q.931 (8)  
len=9
 [Mar 17 16:58:50] VERBOSE[6630] logger.c:  Call Ref: len= 2 (reference 
321/0x141) (Originator)
 [Mar 17 16:58:50] VERBOSE[6630] logger.c:  Message type: DISCONNECT (69)
 [Mar 17 16:58:50] VERBOSE[6630] logger.c:  [08 02 81 90]
 [Mar 17 16:58:50] VERBOSE[6630] logger.c:  Cause (len= 4) [ Ext: 1  Coding: 
CCITT (ITU) standard (0)  Spare: 0  Location: Private network serving the local 
user (1)
 [Mar 17 16:58:50] VERBOSE[6630] logger.c:   Ext: 1  Cause: 
Normal Clearing (16), class = Normal Event (1) ]
 [Mar 17 16:58:50] VERBOSE[6630] logger.c: -- Hungup 'Zap/30-1'
 [Mar 17 16:58:50] VERBOSE[6630] logger.c:   == Spawn extension (from-sip, 
01780471800, 18) exited non-zero on 'SIP/197-b6726980'


Here's an example of the inbound failure:


 [Mar 17 17:04:46] VERBOSE[13006] logger.c: -- Executing [846...@isdn_in:1] 
Ringing(Zap/20-1, ) in new stack
 [Mar 17 17:04:46] VERBOSE[13006] logger.c: q931.c:2844 q931_alerting: call 79 
on channel 20 enters state 7 (Call Received)
 [Mar 17 17:04:46] VERBOSE[13006] logger.c:  Protocol Discriminator: Q.931 (8)