[Asterisk-Users] Asterisk-1.2.1 incomplete DID number on incoming T1 line

[Bob Lichtenberg]

I am presently running asterisk 1.0.9 with AMP and a Sangoma A101 card 
with a T1 line and 12 channels.  It has run solidly for four months.  
It receives a 4 digit DID number "9140".

zaptel.conf
span=1,0,0,esf,b8zs
e&m=1-12

I have been testing Asterisk-1.2.1 on a duplicate set of hardware using 
the same Sangoma card and AMP-1.10.010.  Internally the system works 
fine as well as Voicemail, but when receiving an outside call, the 
first call rings into the system as normal.  The second, third, fourth, 
etc call have only the first DID digit "9" and then the system hangs 
up.  The caller hears a busy signal.  If I restart Asterisk then I can 
repeat the process of one good call and the rest busy signals.  I have 
been in contact with Sangoma, but am not sure that it is a problem with 
their software.  Any thoughts.  Thanks. /var/log/asterisk/full [snip]
****First Call******
Dec 15 05:44:16 VERBOSE[31698] logger.c:     -- Starting simple switch 
on 'Zap/12-1'
Dec 15 05:44:16 DEBUG[31680] acl.c: ##### Testing 192.168.10.135 with 
192.168.0.0
Dec 15 05:44:16 DEBUG[31698] chan_zap.c: DTMF digit: 9 on Zap/12-1
Dec 15 05:44:16 DEBUG[31698] chan_zap.c: DTMF digit: 1 on Zap/12-1
Dec 15 05:44:17 DEBUG[31698] chan_zap.c: DTMF digit: 4 on Zap/12-1
Dec 15 05:44:17 DEBUG[31698] chan_zap.c: DTMF digit: 0 on Zap/12-1
Dec 15 05:44:17 DEBUG[31698] chan_zap.c: Enabled echo cancellation on 
channel 12
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Executing 
SetVar("Zap/12-1", "FROM_DID=9140") in new stack
Dec 15 05:44:17 WARNING[31698] pbx.c: SetVar is deprecated, please use 
Set instead.
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Executing 
Goto("Zap/12-1", "from-pstn|s|1") in new stack
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Goto (from-pstn,s,1)
Dec 15 05:44:17 DEBUG[31698] pbx.c: Expression result is '0'
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Executing 
GotoIf("Zap/12-1", "0?from-pstn-reghours|s|1:") in new stack
Dec 15 05:44:17 DEBUG[31698] pbx.c: Not taking any branch
Dec 15 05:44:17 DEBUG[31698] pbx.c: Expression result is '0'
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Executing 
GotoIf("Zap/12-1", "0?from-pstn-afthours|s|1:") in new stack
Dec 15 05:44:17 DEBUG[31698] pbx.c: Not taking any branch
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Executing 
GotoIfTime("Zap/12-1", 
"8:00-17:00|mon-fri|*|*?from-pstn-reghours|s|1:") in new stack
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Executing 
Goto("Zap/12-1", "from-pstn-afthours|s|1") in new stack
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Goto (from-pstn-afthours,s,1)
Dec 15 05:44:17 DEBUG[31698] pbx.c: Expression result is '1'
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Executing 
GotoIf("Zap/12-1", "1?from-pstn-afthours-nofax|s|1:2") in new stack
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Goto 
(from-pstn-afthours-nofax,s,1)
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Executing 
SetVar("Zap/12-1", "intype=aa_2") in new stack
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Executing 
Cut("Zap/12-1", "intype=intype|-|1") in new stack
Dec 15 05:44:17 WARNING[31698] app_cut.c: The application Cut is 
deprecated.  Please use the CUT() function instead.
Dec 15 05:44:17 DEBUG[31698] pbx.c: Expression result is '0'
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Executing 
GotoIf("Zap/12-1", "0?4:5") in new stack
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Goto 
(from-pstn-afthours-nofax,s,5)
Dec 15 05:44:17 DEBUG[31698] pbx.c: Expression result is '0'
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Executing 
GotoIf("Zap/12-1", "0?6:7") in new stack
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Goto 
(from-pstn-afthours-nofax,s,7)
Dec 15 05:44:17 DEBUG[31698] pbx.c: Expression result is '0'
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Executing 
GotoIf("Zap/12-1", "0?8:11") in new stack
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Goto 
(from-pstn-afthours-nofax,s,11)
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Executing 
Answer("Zap/12-1", "") in new stack
Dec 15 05:44:17 DEBUG[31698] chan_zap.c: Took Zap/12-1 off hook
Dec 15 05:44:17 VERBOSE[31698] logger.c:     -- Executing 
Wait("Zap/12-1", "1") in new stack
Dec 15 05:44:18 VERBOSE[31698] logger.c:     -- Executing 
Goto("Zap/12-1", "aa_2|s|1") in new stack
Dec 15 05:44:18 VERBOSE[31698] logger.c:     -- Goto (aa_2,s,1)



*****Second Call****
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Starting simple switch 
on 'Zap/12-1'
Dec 15 05:44:45 DEBUG[31680] chan_sip.c: Auto destroying call 
'ed661c18-db2fd42-cab69145 at 192.168.10.135'
Dec 15 05:44:45 DEBUG[31710] chan_zap.c: DTMF digit: 9 on Zap/12-1
Dec 15 05:44:45 DEBUG[31710] chan_zap.c: Enabled echo cancellation on 
channel 12
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Executing 
SetVar("Zap/12-1", "FROM_DID=9140") in new stack
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Executing 
Goto("Zap/12-1", "from-pstn|s|1") in new stack
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Goto (from-pstn,s,1)
Dec 15 05:44:45 DEBUG[31710] pbx.c: Expression result is '0'
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Executing 
GotoIf("Zap/12-1", "0?from-pstn-reghours|s|1:") in new stack
Dec 15 05:44:45 DEBUG[31710] pbx.c: Not taking any branch
Dec 15 05:44:45 DEBUG[31710] pbx.c: Expression result is '0'
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Executing 
GotoIf("Zap/12-1", "0?from-pstn-afthours|s|1:") in new stack
Dec 15 05:44:45 DEBUG[31710] pbx.c: Not taking any branch
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Executing 
GotoIfTime("Zap/12-1", 
"8:00-17:00|mon-fri|*|*?from-pstn-reghours|s|1:") in new stack
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Executing 
Goto("Zap/12-1", "from-pstn-afthours|s|1") in new stack
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Goto (from-pstn-afthours,s,1)
Dec 15 05:44:45 DEBUG[31710] pbx.c: Expression result is '1'
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Executing 
GotoIf("Zap/12-1", "1?from-pstn-afthours-nofax|s|1:2") in new stack
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Goto 
(from-pstn-afthours-nofax,s,1)
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Executing 
SetVar("Zap/12-1", "intype=aa_2") in new stack
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Executing 
Cut("Zap/12-1", "intype=intype|-|1") in new stack
Dec 15 05:44:45 DEBUG[31710] pbx.c: Expression result is '0'
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Executing 
GotoIf("Zap/12-1", "0?4:5") in new stack
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Goto 
(from-pstn-afthours-nofax,s,5)
Dec 15 05:44:45 DEBUG[31710] pbx.c: Expression result is '0'
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Executing 
GotoIf("Zap/12-1", "0?6:7") in new stack
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Goto 
(from-pstn-afthours-nofax,s,7)
Dec 15 05:44:45 DEBUG[31710] pbx.c: Expression result is '0'
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Executing 
GotoIf("Zap/12-1", "0?8:11") in new stack
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Goto 
(from-pstn-afthours-nofax,s,11)
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Executing 
Answer("Zap/12-1", "") in new stack
Dec 15 05:44:45 DEBUG[31710] chan_zap.c: Took Zap/12-1 off hook
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Executing 
Wait("Zap/12-1", "1") in new stack
Dec 15 05:44:45 DEBUG[31710] chan_zap.c: Exception on 24, channel 12
Dec 15 05:44:45 DEBUG[31710] chan_zap.c: Got event On hook(1) on 
channel 12 (index 0)
Dec 15 05:44:45 DEBUG[31710] chan_zap.c: disabled echo cancellation on 
channel 12
Dec 15 05:44:45 VERBOSE[31710] logger.c:   == Spawn extension 
(from-pstn-afthours-nofax, s, 12) exited non-zero on 'Zap/12-1'
Dec 15 05:44:45 VERBOSE[31710] logger.c:     -- Executing 
Hangup("Zap/12-1", "") in new stack