[asterisk-users] yellow alarm after weeks without trouble

Jean-Denis Girard jd.girard at sysnux.pf
Tue Feb 6 14:33:23 MST 2007


Hi list,

I'm getting an error on a E1 link to the telco, after some weeks of
operation without trouble.

I have an asterisk with a TE405 in passtrough mode: two E1 are connected
to the Telco, two E1 are connected to 2 Siemens PaBX. Only 15 channels
are used on each E1 (conf is attached).The system has been in production
for nearly a year, and does work flawlessly for weeks, then I
mysteriously get errors on the first PRI span, which is used as primary
clocking source. It happened again this Sunday (while the system was
idle), after six weeks of operation without trouble. Call are dropped,
and users are angry. It has happened  4-5 times during one year.
Reloading zaptel modules and restarting asterisk does bring the system
back to normal.
As far as I can tell, pri debug span 1 shows nothing special (see
attached log).
The Telco says that there is "drift in the synchronization".
System load as shown by top is very low, vmstat shows no CPU spikes,
TE405P has its on interrupt. I already changed the TE405P.
I have other similar systems running without any trouble, so any idea
about improving this installation would be welcome. I can provide more
info if needed. Main differences with my other similar installations
are: two E1 are used, and system is 64 bit (Asus MB with Opteron).

Versions are:
Asterisk 1.2.13 built by root @ asterisk.xxx.xx on a x86_64 running 
Linux on 2006-11-10 16:12:43 UTC
Zaptel Version: 1.2.11 Echo Canceller: KB1
Found TE4XXP at base address fdefe000, remapped to ffffc20000010000
TE4XXP version c01a0164, burst OFF, slip debug: OFF
FALC version: 00000005, Board ID: 00


Thanks,
-- 
Jean-Denis Girard

SysNux                  Systèmes Linux en Polynésie française
http://www.sysnux.pf/   Tél: +689 483 527 / GSM: +689 797 527
-------------- next part --------------
# Zaptel.conf: fichier de configuration bas niveau de zaptel
# SysNux 07/12/2005
# Jean-Denis Girard <jd.girard at sysnux.pf>

loadzone=fr
defaultzone=fr

# 4 canaux T2 (2 sur OPT, 2 sur PaBX). Chaque T2 utilise seulement 
# les 15 premiers canaux B

span=1,1,0,ccs,hdb3
bchan=1-15
dchan=16
#bchan=17-31

span=2,2,0,ccs,hdb3
bchan=32-46
dchan=47
#bchan=48-62

span=3,0,0,ccs,hdb3
bchan=63-77
dchan=78
#bchan=79-93

span=4,0,0,ccs,hdb3
bchan=94-108
dchan=109
#bchan=110-124




-------------- next part --------------
; Zaptata.conf: fichier de configuration des interfaces zap
; 4 T2: 2 connectés à l'OPT, 2 connectés au PaBX
; sur chaque T2 seulement 15 canaux B utilisés
; SysNux 07/12/2005
; Jean-Denis Girard <jd.girard at sysnux.pf>

[channels]
language=fr
switchtype=EuroISDN
usecallerid=yes
callwaiting=no
callwaitingcallerid=no
threewaycalling=no
transfer=no
cancallforward=no
callreturn=no
echocancel=yes
echocancelwhenbridged=yes

pridialplan=national
prilocaldialplan=national
internationalprefix=00
nationalprefix=0689

overlapdial=yes
callerid=asreceived
immediate=no ; XXX

; 2 premiers T2 connectés à l'OPT
context=entrant
signalling=pri_cpe
group=1
channel => 1-15
;channel => 17-31
channel => 32-46
;channel => 48-62

; 2 derniers T2 connectés au PaBX
context=sortant
signalling=pri_net
immediate=no
group=2
channel => 63-77
;channel => 79-93
channel => 94-108
;channel => 110-124




-------------- next part --------------
Jan 31 12:41:45 VERBOSE[9968] logger.c:     -- Hungup 'Zap/68-1'
Jan 31 12:41:46 VERBOSE[32105] logger.c: < Protocol Discriminator: Q.931 (8)  len=39
Jan 31 12:41:46 VERBOSE[32105] logger.c: < Call Ref: len= 2 (reference 25024/0x61C0) (Terminator)
Jan 31 12:41:46 VERBOSE[32105] logger.c: < Message type: RELEASE (77)
Jan 31 12:41:46 VERBOSE[32105] logger.c: < [1c 20 91 a1 1d 02 02 01 8d 02 01 24 30 14 30 12 a1 10 30 06 02 01 01 02 01 01 30 06 02 01 00 02 01 02]
Jan 31 12:41:46 VERBOSE[32105] logger.c: < Facility (len=34, codeset=0) [ Jan 31 12:41:46 VERBOSE[32105] logger.c: < Facility (len=34, codeset=0) [ 0x91, 0xa1, 0x1d, 0x02, 0x02, 0x01, 0x8d, 0x02, 0x01, 0x24, '0', 0x14, '0', 0x12, 0xa1, 0x10, '0', 0x06, 0x02, 0x01, 0x01, 0x02, 0x01, 0x01, '0', 0x06, 0x02, 0x01, 0x00, 0x02, 0x01, 0x02Jan 31 12:41:46 VERBOSE[32105] logger.c: < Facility (len=34, codeset=0) [ 0x91, 0xa1, 0x1d, 0x02, 0x02, 0x01, 0x8d, 0x02, 0x01, 0x24, '0', 0x14, '0', 0x12, 0xa1, 0x10, '0', 0x06, 0x02, 0x01, 0x01, 0x02, 0x01, 0x01, '0', 0x06, 0x02, 0x01, 0x00, 0x02, 0x01, 0x02 ]
Jan 31 12:41:46 VERBOSE[32105] logger.c: -- Processing IE 28 (cs0, Facility)
Jan 31 12:41:46 VERBOSE[32105] logger.c: Handle Q.932 ROSE Invoke component
Jan 31 12:41:46 VERBOSE[32105] logger.c: !! Don't know how to handle 0x30 in AOC-E RecordedUnitsList
Jan 31 12:41:46 VERBOSE[32105] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Release Request
Jan 31 12:41:46 VERBOSE[32105] logger.c: > Protocol Discriminator: Q.931 (8)  len=9
Jan 31 12:41:46 VERBOSE[32105] logger.c: > Call Ref: len= 2 (reference 25024/0x61C0) (Originator)
Jan 31 12:41:46 VERBOSE[32105] logger.c: > Message type: RELEASE COMPLETE (90)
Jan 31 12:41:46 VERBOSE[32105] logger.c: > [08 02 81 90]
Jan 31 12:41:46 VERBOSE[32105] logger.c: > Cause (len= 4) [ Ext: 1  Coding: CCITT (ITU) standard (0) 0: 0   Location: Private network serving the local user (1)
Jan 31 12:41:46 VERBOSE[32105] logger.c: >                  Ext: 1  Cause: Normal Clearing (16), class = Normal Event (1) ]
Jan 31 12:41:46 VERBOSE[32105] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Null
Jan 31 12:41:46 VERBOSE[32105] logger.c: NEW_HANGUP DEBUG: Destroying the call, ourstate Null, peerstate Null
Jan 31 12:41:46 VERBOSE[32105] logger.c:     -- Channel 0/1, span 1 received AOC-E charging 2 units
Jan 31 12:42:26 VERBOSE[32105] logger.c: < Protocol Discriminator: Q.931 (8)  len=37
Jan 31 12:42:26 VERBOSE[32105] logger.c: < Call Ref: len= 2 (reference 5753/0x1679) (Originator)
Jan 31 12:42:26 VERBOSE[32105] logger.c: < Message type: SETUP (5)
Jan 31 12:42:26 VERBOSE[32105] logger.c: < [a1]
Jan 31 12:42:26 VERBOSE[32105] logger.c: < Sending Complete (len= 1)
Jan 31 12:42:26 VERBOSE[32105] logger.c: < [04 03 80 90 a3]
Jan 31 12:42:26 VERBOSE[32105] logger.c: < Bearer Capability (len= 5) [ Ext: 1  Q.931 Std: 0  Info transfer capability: Speech (0)
Jan 31 12:42:26 VERBOSE[32105] logger.c: <                              Ext: 1  Trans mode/rate: 64kbps, circuit-mode (16)
Jan 31 12:42:26 VERBOSE[32105] logger.c: <                              Ext: 1  User information layer 1: A-Law (35)
Jan 31 12:42:26 VERBOSE[32105] logger.c: < [18 03 a9 83 86]
Jan 31 12:42:26 VERBOSE[32105] logger.c: < Channel ID (len= 5) [ Ext: 1  IntID: Implicit, PRI Spare: 0, Exclusive Dchan: 0
Jan 31 12:42:26 VERBOSE[32105] logger.c: <                        ChanSel: Reserved
Jan 31 12:42:26 VERBOSE[32105] logger.c: <                       Ext: 1  Coding: 0   Number Specified   Channel Type: 3
Jan 31 12:42:26 VERBOSE[32105] logger.c: <                       Ext: 1  Channel: 6 ]
Jan 31 12:42:26 VERBOSE[32105] logger.c: < [6c 08 21 83 35 30 30 33 30 30]
Jan 31 12:42:26 VERBOSE[32105] logger.c: < Calling Number (len=10) [ Ext: 0  TON: National Number (2)  NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1)
Jan 31 12:42:26 VERBOSE[32105] logger.c: <                           Presentation: Presentation allowed of network provided number (3) '500300' ]
Jan 31 12:42:26 VERBOSE[32105] logger.c: < [70 05 81 37 30 39 36]
Jan 31 12:42:26 VERBOSE[32105] logger.c: < Called Number (len= 7) [ Ext: 1  TON: Unknown Number Type (0)  NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1) '7096' ]
Jan 31 12:42:26 VERBOSE[32105] logger.c: < [7d 02 91 81]
Jan 31 12:42:26 VERBOSE[32105] logger.c: < IE: High-layer Compatibility (len = 4)
Jan 31 12:42:26 VERBOSE[32105] logger.c: -- Making new call for cr 5753
Jan 31 12:42:26 VERBOSE[32105] logger.c: -- Processing Q.931 Call Setup
Jan 31 12:42:26 VERBOSE[32105] logger.c: -- Processing IE 161 (cs0, Sending Complete)
Jan 31 12:42:26 VERBOSE[32105] logger.c: -- Processing IE 4 (cs0, Bearer Capability)
Jan 31 12:42:26 VERBOSE[32105] logger.c: -- Processing IE 24 (cs0, Channel Identification)
Jan 31 12:42:26 VERBOSE[32105] logger.c: -- Processing IE 108 (cs0, Calling Party Number)
Jan 31 12:42:26 VERBOSE[32105] logger.c: -- Processing IE 112 (cs0, Called Party Number)
Jan 31 12:42:26 VERBOSE[32105] logger.c: -- Processing IE 125 (cs0, High-layer Compatibility)
Jan 31 12:42:26 VERBOSE[32105] logger.c: > Protocol Discriminator: Q.931 (8)  len=10
Jan 31 12:42:26 VERBOSE[32105] logger.c: > Call Ref: len= 2 (reference 5753/0x1679) (Terminator)
Jan 31 12:42:26 VERBOSE[32105] logger.c: > Message type: CALL PROCEEDING (2)
Jan 31 12:42:26 VERBOSE[32105] logger.c: > [18 03 a9 83 86]
Jan 31 12:42:26 VERBOSE[32105] logger.c: > Channel ID (len= 5) [ Ext: 1  IntID: Implicit, PRI Spare: 0, Exclusive Dchan: 0
Jan 31 12:42:26 VERBOSE[32105] logger.c: >                        ChanSel: Reserved
Jan 31 12:42:26 VERBOSE[32105] logger.c: >                       Ext: 1  Coding: 0   Number Specified   Channel Type: 3
Jan 31 12:42:26 VERBOSE[32105] logger.c: >                       Ext: 1  Channel: 6 ]
Jan 31 12:42:26 VERBOSE[32105] logger.c:     -- Accepting call from '0689500300' to '7096' on channel 0/6, span 1
Jan 31 12:42:26 DEBUG[32105] chan_zap.c: Enabled echo cancellation on channel 6
Jan 31 12:42:26 VERBOSE[10031] logger.c:     -- Executing Dial("Zap/6-1", "Zap/g2/7096|90|r") in new stack
Jan 31 12:42:26 VERBOSE[10031] logger.c:     -- Requested transfer capability: 0x00 - SPEECH
Jan 31 12:42:26 VERBOSE[10031] logger.c:     -- Called g2/7096
Jan 31 12:42:26 DEBUG[10031] chan_zap.c: Requested indication 3 on channel Zap/6-1
Jan 31 12:42:26 VERBOSE[10031] logger.c: > Protocol Discriminator: Q.931 (8)  len=9
Jan 31 12:42:26 VERBOSE[10031] logger.c: > Call Ref: len= 2 (reference 5753/0x1679) (Terminator)
Jan 31 12:42:26 VERBOSE[10031] logger.c: > Message type: ALERTING (1)
Jan 31 12:42:26 VERBOSE[10031] logger.c: > [1e 02 81 88]
Jan 31 12:42:26 VERBOSE[10031] logger.c: > Progress Indicator (len= 4) [ Ext: 1  Coding: CCITT (ITU) standard (0) 0: 0   Location: Private network serving the local user (1)
Jan 31 12:42:26 VERBOSE[10031] logger.c: >                               Ext: 1  Progress Description: Inband information or appropriate pattern now available. (8) ]
Jan 31 12:42:26 DEBUG[32107] chan_zap.c: Enabled echo cancellation on channel 63
Jan 31 12:42:26 VERBOSE[10031] logger.c:     -- Zap/63-1 is ringing
Jan 31 12:42:44 DEBUG[32107] chan_zap.c: Echo cancellation already on
Jan 31 12:42:44 VERBOSE[10031] logger.c:     -- Zap/63-1 answered Zap/6-1
Jan 31 12:42:44 DEBUG[10031] chan_zap.c: Requested indication -1 on channel Zap/6-1
Jan 31 12:42:44 VERBOSE[10031] logger.c: > Protocol Discriminator: Q.931 (8)  len=14
Jan 31 12:42:44 VERBOSE[10031] logger.c: > Call Ref: len= 2 (reference 5753/0x1679) (Terminator)
Jan 31 12:42:44 VERBOSE[10031] logger.c: > Message type: CONNECT (7)
Jan 31 12:42:44 VERBOSE[10031] logger.c: > [18 03 a9 83 86]
Jan 31 12:42:44 VERBOSE[10031] logger.c: > Channel ID (len= 5) [ Ext: 1  IntID: Implicit, PRI Spare: 0, Exclusive Dchan: 0
Jan 31 12:42:44 VERBOSE[10031] logger.c: >                        ChanSel: Reserved
Jan 31 12:42:44 VERBOSE[10031] logger.c: >                       Ext: 1  Coding: 0   Number Specified   Channel Type: 3
Jan 31 12:42:44 VERBOSE[10031] logger.c: >                       Ext: 1  Channel: 6 ]
Jan 31 12:42:44 VERBOSE[10031] logger.c: > [1e 02 81 82]
Jan 31 12:42:44 VERBOSE[10031] logger.c: > Progress Indicator (len= 4) [ Ext: 1  Coding: CCITT (ITU) standard (0) 0: 0   Location: Private network serving the local user (1)
Jan 31 12:42:44 VERBOSE[10031] logger.c: >                               Ext: 1  Progress Description: Called equipment is non-ISDN. (2) ]
Jan 31 12:42:44 VERBOSE[10031] logger.c:     -- Attempting native bridge of Zap/6-1 and Zap/63-1
Jan 31 12:42:44 DEBUG[10031] chan_zap.c: master: 6, slave: 63, nothingok: 0
Jan 31 12:42:44 DEBUG[10031] chan_zap.c: Stopping tones on 6/0 talking to 63/0
Jan 31 12:42:44 DEBUG[10031] chan_zap.c: Stopping tones on 63/0 talking to 6/0
Jan 31 12:42:44 DEBUG[10031] chan_zap.c: Making 63 slave to master 6 at 0
Jan 31 12:42:44 DEBUG[10031] chan_zap.c: Added 48 to conference 9/6
Jan 31 12:42:44 DEBUG[10031] chan_zap.c: Added 23 to conference 9/63
Jan 31 12:42:44 DEBUG[10031] chan_zap.c: Updated conferencing on 6, with 0 conference users
Jan 31 12:42:44 DEBUG[10031] chan_zap.c: Updated conferencing on 63, with 0 conference users
Jan 31 12:42:45 VERBOSE[32105] logger.c: < Protocol Discriminator: Q.931 (8)  len=5
Jan 31 12:42:45 VERBOSE[32105] logger.c: < Call Ref: len= 2 (reference 5753/0x1679) (Originator)
Jan 31 12:42:45 VERBOSE[32105] logger.c: < Message type: CONNECT ACKNOWLEDGE (15)
Jan 31 12:42:47 VERBOSE[32106] logger.c:     -- Accepting call from '0689712945' to '7128' on channel 0/13, span 2
Jan 31 12:42:47 DEBUG[32106] chan_zap.c: Enabled echo cancellation on channel 44
Jan 31 12:42:47 VERBOSE[10046] logger.c:     -- Executing Dial("Zap/44-1", "Zap/g2/7128|90|r") in new stack
Jan 31 12:42:47 VERBOSE[10046] logger.c:     -- Requested transfer capability: 0x00 - SPEECH
Jan 31 12:42:47 VERBOSE[10046] logger.c:     -- Called g2/7128
Jan 31 12:42:47 DEBUG[10046] chan_zap.c: Requested indication 3 on channel Zap/44-1
Jan 31 12:42:47 DEBUG[32107] chan_zap.c: Enabled echo cancellation on channel 64
Jan 31 12:42:47 VERBOSE[10046] logger.c:     -- Zap/64-1 is ringing
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Detected alarm on channel 1: Yellow Alarm
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 1
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Detected alarm on channel 2: Yellow Alarm
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 2
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Detected alarm on channel 3: Yellow Alarm
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 3
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Detected alarm on channel 4: Yellow Alarm
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 4
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Detected alarm on channel 5: Yellow Alarm
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 5
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Detected alarm on channel 7: Yellow Alarm
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 7
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Detected alarm on channel 8: Yellow Alarm
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 8
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Detected alarm on channel 9: Yellow Alarm
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 9
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Detected alarm on channel 10: Yellow Alarm
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 10
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Detected alarm on channel 11: Yellow Alarm
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 11
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Detected alarm on channel 12: Yellow Alarm
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 12
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Detected alarm on channel 13: Yellow Alarm
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 13
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Detected alarm on channel 14: Yellow Alarm
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 14
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Detected alarm on channel 15: Yellow Alarm
Jan 31 12:42:48 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 15
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Exception on 23, channel 6
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Got event Alarm(4) on channel 6 (index 0)
Jan 31 12:42:48 VERBOSE[10031] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Active, peerstate Active
Jan 31 12:42:48 VERBOSE[10031] logger.c: Write to 78 failed: Unknown error 500
Jan 31 12:42:48 VERBOSE[10031] logger.c: Short write: 0/15 (Unknown error 500)
Jan 31 12:42:48 VERBOSE[10031] logger.c: > Protocol Discriminator: Q.931 (8)  len=9
Jan 31 12:42:48 VERBOSE[10031] logger.c: > Call Ref: len= 2 (reference 5753/0x1679) (Terminator)
Jan 31 12:42:48 VERBOSE[10031] logger.c: > Message type: DISCONNECT (69)
Jan 31 12:42:48 VERBOSE[10031] logger.c: > [08 02 81 90]
Jan 31 12:42:48 VERBOSE[10031] logger.c: > Cause (len= 4) [ Ext: 1  Coding: CCITT (ITU) standard (0) 0: 0   Location: Private network serving the local user (1)
Jan 31 12:42:48 VERBOSE[10031] logger.c: >                  Ext: 1  Cause: Normal Clearing (16), class = Normal Event (1) ]
Jan 31 12:42:48 VERBOSE[10031] logger.c: NEW_HANGUP DEBUG: Destroying the call, ourstate Disconnect Request, peerstate Disconnect Indication
Jan 31 12:42:48 WARNING[10031] chan_zap.c: Detected alarm on channel 6: Yellow Alarm
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: disabled echo cancellation on channel 6
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Enabled echo cancellation on channel 6
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Echo cancellation already on
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Unlinking slave 63 from 6
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Removed 48 from conference 9/6
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Removed 23 from conference 9/63
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Updated conferencing on 6, with 0 conference users
Jan 31 12:42:48 DEBUG[10031] channel.c: Returning from native bridge, channels: Zap/6-1, Zap/63-1
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/63-1
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Hangup: channel: 63 index = 0, normal = 48, callwait = -1, thirdcall = -1
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Not yet hungup...  Calling hangup once with icause, and clearing call
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: disabled echo cancellation on channel 63
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/63-1
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Updated conferencing on 63, with 0 conference users
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/63-1
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: disabled echo cancellation on channel 63
Jan 31 12:42:48 VERBOSE[10031] logger.c:     -- Hungup 'Zap/63-1'
Jan 31 12:42:48 DEBUG[10031] app_dial.c: Exiting with DIALSTATUS=ANSWER.
Jan 31 12:42:48 VERBOSE[10031] logger.c:   == Spawn extension (entrant, 7096, 1) exited non-zero on 'Zap/6-1'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is '0689500300'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is '0689500300'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is '7096'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is 'entrant'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is 'Zap/6-1'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is 'Zap/63-1'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is 'Dial'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is 'Zap/g2/7096|90|r'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is '2007-01-31 12:42:26'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is '2007-01-31 12:42:44'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is '2007-01-31 12:42:48'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is '22'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is '4'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is 'ANSWERED'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is 'DOCUMENTATION'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is '(null)'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is '1170265346.137248'
Jan 31 12:42:48 DEBUG[10031] pbx.c: Function result is '(null)'
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/6-1
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Hangup: channel: 6 index = 0, normal = 23, callwait = -1, thirdcall = -1
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: disabled echo cancellation on channel 6
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/6-1
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Updated conferencing on 6, with 0 conference users
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/6-1
Jan 31 12:42:48 DEBUG[10031] chan_zap.c: disabled echo cancellation on channel 6
Jan 31 12:42:48 VERBOSE[10031] logger.c:     -- Hungup 'Zap/6-1'
Jan 31 12:42:48 NOTICE[32105] chan_zap.c: PRI got event: Alarm (4) on Primary D-channel of span 1
Jan 31 12:42:48 WARNING[32105] chan_zap.c: No D-channels available!  Using Primary channel 16 as D-channel anyway!
Jan 31 12:42:51 VERBOSE[32105] logger.c:   == Primary D-Channel on span 1 down
Jan 31 12:42:51 WARNING[32105] chan_zap.c: No D-channels available!  Using Primary channel 16 as D-channel anyway!
Jan 31 12:42:55 VERBOSE[32105] logger.c: !! Got S-frame while link down
Jan 31 12:42:56 VERBOSE[32105] logger.c: !! Got S-frame while link down
Jan 31 12:42:56 NOTICE[32109] chan_zap.c: Alarm cleared on channel 1
Jan 31 12:42:56 NOTICE[32109] chan_zap.c: Alarm cleared on channel 2
Jan 31 12:42:56 NOTICE[32109] chan_zap.c: Alarm cleared on channel 3
Jan 31 12:42:56 NOTICE[32109] chan_zap.c: Alarm cleared on channel 4
Jan 31 12:42:56 NOTICE[32109] chan_zap.c: Alarm cleared on channel 5
Jan 31 12:42:56 NOTICE[32109] chan_zap.c: Alarm cleared on channel 6
Jan 31 12:42:56 NOTICE[32109] chan_zap.c: Alarm cleared on channel 7
Jan 31 12:42:56 NOTICE[32109] chan_zap.c: Alarm cleared on channel 8
Jan 31 12:42:56 NOTICE[32109] chan_zap.c: Alarm cleared on channel 9
Jan 31 12:42:56 NOTICE[32109] chan_zap.c: Alarm cleared on channel 10
Jan 31 12:42:56 NOTICE[32109] chan_zap.c: Alarm cleared on channel 11
Jan 31 12:42:56 NOTICE[32109] chan_zap.c: Alarm cleared on channel 12
Jan 31 12:42:56 NOTICE[32109] chan_zap.c: Alarm cleared on channel 13
Jan 31 12:42:56 NOTICE[32109] chan_zap.c: Alarm cleared on channel 14
Jan 31 12:42:56 NOTICE[32109] chan_zap.c: Alarm cleared on channel 15
Jan 31 12:42:56 NOTICE[32105] chan_zap.c: PRI got event: No more alarm (5) on Primary D-channel of span 1
Jan 31 12:42:56 VERBOSE[32105] logger.c:   == Primary D-Channel on span 1 up
Jan 31 12:42:56 VERBOSE[32105] logger.c: < Protocol Discriminator: Q.931 (8)  len=5
Jan 31 12:42:56 VERBOSE[32105] logger.c: < Call Ref: len= 2 (reference 5753/0x1679) (Originator)
Jan 31 12:42:56 VERBOSE[32105] logger.c: < Message type: STATUS ENQUIRY (117)
Jan 31 12:42:56 VERBOSE[32105] logger.c: -- Making new call for cr 5753
Jan 31 12:42:56 VERBOSE[32105] logger.c: > Protocol Discriminator: Q.931 (8)  len=9
Jan 31 12:42:56 VERBOSE[32105] logger.c: > Call Ref: len= 2 (reference 5753/0x1679) (Terminator)
Jan 31 12:42:56 VERBOSE[32105] logger.c: > Message type: RELEASE COMPLETE (90)
Jan 31 12:42:56 VERBOSE[32105] logger.c: > [08 02 81 d1]
Jan 31 12:42:56 VERBOSE[32105] logger.c: > Cause (len= 4) [ Ext: 1  Coding: CCITT (ITU) standard (0) 0: 0   Location: Private network serving the local user (1)
Jan 31 12:42:56 VERBOSE[32105] logger.c: >                  Ext: 1  Cause: Invalid call reference value (81), class = Invalid message (5) ]
Jan 31 12:42:56 VERBOSE[32105] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Null
Jan 31 12:42:56 VERBOSE[32105] logger.c: NEW_HANGUP DEBUG: Destroying the call, ourstate Null, peerstate Null
Jan 31 12:42:57 DEBUG[32107] chan_zap.c: Echo cancellation already on
Jan 31 12:42:57 VERBOSE[10046] logger.c:     -- Zap/64-1 answered Zap/44-1
Jan 31 12:42:57 DEBUG[10046] chan_zap.c: Requested indication -1 on channel Zap/44-1
Jan 31 12:42:57 VERBOSE[10046] logger.c:     -- Attempting native bridge of Zap/44-1 and Zap/64-1
Jan 31 12:42:57 DEBUG[10046] chan_zap.c: master: 44, slave: 64, nothingok: 0
Jan 31 12:42:57 DEBUG[10046] chan_zap.c: Stopping tones on 44/0 talking to 64/0
Jan 31 12:42:57 DEBUG[10046] chan_zap.c: Stopping tones on 64/0 talking to 44/0
Jan 31 12:42:57 DEBUG[10046] chan_zap.c: Making 64 slave to master 44 at 0
Jan 31 12:42:57 DEBUG[10046] chan_zap.c: Added 49 to conference 9/44
Jan 31 12:42:57 DEBUG[10046] chan_zap.c: Added 45 to conference 9/64
Jan 31 12:42:57 DEBUG[10046] chan_zap.c: Updated conferencing on 44, with 0 conference users
Jan 31 12:42:57 DEBUG[10046] chan_zap.c: Updated conferencing on 64, with 0 conference users
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Detected alarm on channel 1: Yellow Alarm
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 1
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Detected alarm on channel 2: Yellow Alarm
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 2
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Detected alarm on channel 3: Yellow Alarm
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 3
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Detected alarm on channel 4: Yellow Alarm
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 4
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Detected alarm on channel 5: Yellow Alarm
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 5
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Detected alarm on channel 6: Yellow Alarm
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 6
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Detected alarm on channel 7: Yellow Alarm
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 7
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Detected alarm on channel 8: Yellow Alarm
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 8
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Detected alarm on channel 9: Yellow Alarm
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 9
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Detected alarm on channel 10: Yellow Alarm
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 10
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Detected alarm on channel 11: Yellow Alarm
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 11
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Detected alarm on channel 12: Yellow Alarm
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 12
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Detected alarm on channel 13: Yellow Alarm
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 13
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Detected alarm on channel 14: Yellow Alarm
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 14
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Detected alarm on channel 15: Yellow Alarm
Jan 31 12:42:58 WARNING[32109] chan_zap.c: Unable to disable echo cancellation on channel 15
Jan 31 12:42:58 NOTICE[32105] chan_zap.c: PRI got event: Alarm (4) on Primary D-channel of span 1
Jan 31 12:42:58 WARNING[32105] chan_zap.c: No D-channels available!  Using Primary channel 16 as D-channel anyway!
Jan 31 12:42:58 VERBOSE[32106] logger.c:     -- Accepting call from '0689500300' to '7096' on channel 0/14, span 2
Jan 31 12:42:58 DEBUG[32106] chan_zap.c: Enabled echo cancellation on channel 45
Jan 31 12:42:58 VERBOSE[10060] logger.c:     -- Executing Dial("Zap/45-1", "Zap/g2/7096|90|r") in new stack
Jan 31 12:42:58 VERBOSE[10060] logger.c:     -- Requested transfer capability: 0x00 - SPEECH
Jan 31 12:42:58 VERBOSE[10060] logger.c:     -- Called g2/7096
Jan 31 12:42:58 DEBUG[10060] chan_zap.c: Requested indication 3 on channel Zap/45-1
Jan 31 12:42:58 DEBUG[32107] chan_zap.c: Enabled echo cancellation on channel 63
Jan 31 12:42:58 VERBOSE[10060] logger.c:     -- Zap/63-1 is ringing
Jan 31 12:43:00 DEBUG[32107] chan_zap.c: Echo cancellation already on
Jan 31 12:43:00 VERBOSE[10060] logger.c:     -- Zap/63-1 answered Zap/45-1
Jan 31 12:43:00 DEBUG[10060] chan_zap.c: Requested indication -1 on channel Zap/45-1
Jan 31 12:43:00 VERBOSE[10060] logger.c:     -- Attempting native bridge of Zap/45-1 and Zap/63-1
Jan 31 12:43:00 DEBUG[10060] chan_zap.c: master: 45, slave: 63, nothingok: 0
Jan 31 12:43:00 DEBUG[10060] chan_zap.c: Stopping tones on 45/0 talking to 63/0
Jan 31 12:43:00 DEBUG[10060] chan_zap.c: Stopping tones on 63/0 talking to 45/0
Jan 31 12:43:00 DEBUG[10060] chan_zap.c: Making 63 slave to master 45 at 0
Jan 31 12:43:00 DEBUG[10060] chan_zap.c: Added 48 to conference 9/45
Jan 31 12:43:00 DEBUG[10060] chan_zap.c: Added 46 to conference 9/63
Jan 31 12:43:00 DEBUG[10060] chan_zap.c: Updated conferencing on 45, with 0 conference users
Jan 31 12:43:00 DEBUG[10060] chan_zap.c: Updated conferencing on 63, with 0 conference users
Jan 31 12:43:05 VERBOSE[32107] logger.c:     -- Channel 0/2, span 3 got hangup request
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Echo cancellation already on
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Echo cancellation already on
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Unlinking slave 64 from 44
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Removed 49 from conference 9/44
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Removed 45 from conference 9/64
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Updated conferencing on 44, with 0 conference users
Jan 31 12:43:05 DEBUG[10046] channel.c: Returning from native bridge, channels: Zap/44-1, Zap/64-1
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/64-1
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Hangup: channel: 64 index = 0, normal = 49, callwait = -1, thirdcall = -1
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Not yet hungup...  Calling hangup once with icause, and clearing call
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: disabled echo cancellation on channel 64
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/64-1
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Updated conferencing on 64, with 0 conference users
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/64-1
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: disabled echo cancellation on channel 64
Jan 31 12:43:05 VERBOSE[10046] logger.c:     -- Hungup 'Zap/64-1'
Jan 31 12:43:05 DEBUG[10046] app_dial.c: Exiting with DIALSTATUS=ANSWER.
Jan 31 12:43:05 VERBOSE[10046] logger.c:   == Spawn extension (entrant, 7128, 1) exited non-zero on 'Zap/44-1'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is '0689712945'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is '0689712945'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is '7128'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is 'entrant'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is 'Zap/44-1'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is 'Zap/64-1'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is 'Dial'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is 'Zap/g2/7128|90|r'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is '2007-01-31 12:42:47'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is '2007-01-31 12:42:57'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is '2007-01-31 12:43:05'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is '18'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is '8'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is 'ANSWERED'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is 'DOCUMENTATION'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is '(null)'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is '1170265367.137250'
Jan 31 12:43:05 DEBUG[10046] pbx.c: Function result is '(null)'
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/44-1
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Hangup: channel: 44 index = 0, normal = 45, callwait = -1, thirdcall = -1
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Not yet hungup...  Calling hangup once with icause, and clearing call
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: disabled echo cancellation on channel 44
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/44-1
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Updated conferencing on 44, with 0 conference users
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/44-1
Jan 31 12:43:05 DEBUG[10046] chan_zap.c: disabled echo cancellation on channel 44
Jan 31 12:43:05 VERBOSE[10046] logger.c:     -- Hungup 'Zap/44-1'
Jan 31 12:43:06 NOTICE[32109] chan_zap.c: Alarm cleared on channel 1
Jan 31 12:43:06 NOTICE[32109] chan_zap.c: Alarm cleared on channel 2
Jan 31 12:43:06 NOTICE[32109] chan_zap.c: Alarm cleared on channel 3
Jan 31 12:43:06 NOTICE[32109] chan_zap.c: Alarm cleared on channel 4
Jan 31 12:43:06 NOTICE[32109] chan_zap.c: Alarm cleared on channel 5
Jan 31 12:43:06 NOTICE[32109] chan_zap.c: Alarm cleared on channel 6
Jan 31 12:43:06 NOTICE[32109] chan_zap.c: Alarm cleared on channel 7
Jan 31 12:43:06 NOTICE[32109] chan_zap.c: Alarm cleared on channel 8
Jan 31 12:43:06 NOTICE[32109] chan_zap.c: Alarm cleared on channel 9
Jan 31 12:43:06 NOTICE[32109] chan_zap.c: Alarm cleared on channel 10
Jan 31 12:43:06 NOTICE[32109] chan_zap.c: Alarm cleared on channel 11
Jan 31 12:43:06 NOTICE[32109] chan_zap.c: Alarm cleared on channel 12
Jan 31 12:43:06 NOTICE[32109] chan_zap.c: Alarm cleared on channel 13
Jan 31 12:43:06 NOTICE[32109] chan_zap.c: Alarm cleared on channel 14
Jan 31 12:43:06 NOTICE[32109] chan_zap.c: Alarm cleared on channel 15
Jan 31 12:43:06 NOTICE[32105] chan_zap.c: PRI got event: No more alarm (5) on Primary D-channel of span 1
Jan 31 12:43:07 VERBOSE[32105] logger.c:   == Primary D-Channel on span 1 up
Jan 31 12:43:16 VERBOSE[32105] logger.c: > Protocol Discriminator: Q.931 (8)  len=13
Jan 31 12:43:16 VERBOSE[32105] logger.c: > Call Ref: len= 2 (reference 0/0x0) (Originator)
Jan 31 12:43:16 VERBOSE[32105] logger.c: > Message type: RESTART (70)
Jan 31 12:43:16 VERBOSE[32105] logger.c: > [18 03 a9 83 81]
Jan 31 12:43:16 VERBOSE[32105] logger.c: > Channel ID (len= 5) [ Ext: 1  IntID: Implicit, PRI Spare: 0, Exclusive Dchan: 0
Jan 31 12:43:16 VERBOSE[32105] logger.c: >                        ChanSel: Reserved
Jan 31 12:43:16 VERBOSE[32105] logger.c: >                       Ext: 1  Coding: 0   Number Specified   Channel Type: 3
Jan 31 12:43:16 VERBOSE[32105] logger.c: >                       Ext: 1  Channel: 1 ]
Jan 31 12:43:16 VERBOSE[32105] logger.c: > [79 01 80]
Jan 31 12:43:16 VERBOSE[32105] logger.c: > Restart Indentifier (len= 3) [ Ext: 1  Spare: 0  Resetting Indicated Channel (0) ]
Jan 31 12:43:17 VERBOSE[32105] logger.c: < Protocol Discriminator: Q.931 (8)  len=31
Jan 31 12:43:17 VERBOSE[32105] logger.c: < Call Ref: len= 2 (reference 5754/0x167A) (Originator)
Jan 31 12:43:17 VERBOSE[32105] logger.c: < Message type: SETUP (5)
Jan 31 12:43:17 VERBOSE[32105] logger.c: < [a1]
Jan 31 12:43:17 VERBOSE[32105] logger.c: < Sending Complete (len= 1)
Jan 31 12:43:17 VERBOSE[32105] logger.c: < [04 03 90 90 a3]
Jan 31 12:43:17 VERBOSE[32105] logger.c: < Bearer Capability (len= 5) [ Ext: 1  Q.931 Std: 0  Info transfer capability: 3.1kHz audio (16)
Jan 31 12:43:17 VERBOSE[32105] logger.c: <                              Ext: 1  Trans mode/rate: 64kbps, circuit-mode (16)
Jan 31 12:43:17 VERBOSE[32105] logger.c: <                              Ext: 1  User information layer 1: A-Law (35)
Jan 31 12:43:17 VERBOSE[32105] logger.c: < [18 03 a9 83 87]
Jan 31 12:43:17 VERBOSE[32105] logger.c: < Channel ID (len= 5) [ Ext: 1  IntID: Implicit, PRI Spare: 0, Exclusive Dchan: 0
Jan 31 12:43:17 VERBOSE[32105] logger.c: <                        ChanSel: Reserved
Jan 31 12:43:17 VERBOSE[32105] logger.c: <                       Ext: 1  Coding: 0   Number Specified   Channel Type: 3
Jan 31 12:43:17 VERBOSE[32105] logger.c: <                       Ext: 1  Channel: 7 ]
Jan 31 12:43:17 VERBOSE[32105] logger.c: < [1e 02 82 83]
Jan 31 12:43:17 VERBOSE[32105] logger.c: < Progress Indicator (len= 4) [ Ext: 1  Coding: CCITT (ITU) standard (0) 0: 0   Location: Public network serving the local user (2)
Jan 31 12:43:17 VERBOSE[32105] logger.c: <                               Ext: 1  Progress Description: Calling equipment is non-ISDN. (3) ]
Jan 31 12:43:17 VERBOSE[32105] logger.c: < [6c 02 00 a3]
Jan 31 12:43:17 VERBOSE[32105] logger.c: < Calling Number (len= 4) [ Ext: 0  TON: Unknown Number Type (0)  NPI: Unknown Number Plan (0)
Jan 31 12:43:17 VERBOSE[32105] logger.c: <                           Presentation: Presentation prohibited of network provided number (35) '' ]
Jan 31 12:43:17 VERBOSE[32105] logger.c: < [70 05 81 37 30 34 30]
Jan 31 12:43:17 VERBOSE[32105] logger.c: < Called Number (len= 7) [ Ext: 1  TON: Unknown Number Type (0)  NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1) '7040' ]
Jan 31 12:43:17 VERBOSE[32105] logger.c: -- Making new call for cr 5754
Jan 31 12:43:17 VERBOSE[32105] logger.c: -- Processing Q.931 Call Setup
Jan 31 12:43:17 VERBOSE[32105] logger.c: -- Processing IE 161 (cs0, Sending Complete)
Jan 31 12:43:17 VERBOSE[32105] logger.c: -- Processing IE 4 (cs0, Bearer Capability)
Jan 31 12:43:17 VERBOSE[32105] logger.c: -- Processing IE 24 (cs0, Channel Identification)
Jan 31 12:43:17 VERBOSE[32105] logger.c: -- Processing IE 30 (cs0, Progress Indicator)
Jan 31 12:43:17 VERBOSE[32105] logger.c: -- Processing IE 108 (cs0, Calling Party Number)
Jan 31 12:43:17 VERBOSE[32105] logger.c: -- Processing IE 112 (cs0, Called Party Number)
Jan 31 12:43:17 VERBOSE[32105] logger.c: > Protocol Discriminator: Q.931 (8)  len=10
Jan 31 12:43:17 VERBOSE[32105] logger.c: > Call Ref: len= 2 (reference 5754/0x167A) (Terminator)
Jan 31 12:43:17 VERBOSE[32105] logger.c: > Message type: CALL PROCEEDING (2)
Jan 31 12:43:17 VERBOSE[32105] logger.c: > [18 03 a9 83 87]
Jan 31 12:43:17 VERBOSE[32105] logger.c: > Channel ID (len= 5) [ Ext: 1  IntID: Implicit, PRI Spare: 0, Exclusive Dchan: 0
Jan 31 12:43:17 VERBOSE[32105] logger.c: >                        ChanSel: Reserved
Jan 31 12:43:17 VERBOSE[32105] logger.c: >                       Ext: 1  Coding: 0   Number Specified   Channel Type: 3
Jan 31 12:43:17 VERBOSE[32105] logger.c: >                       Ext: 1  Channel: 7 ]


More information about the asterisk-users mailing list