[Asterisk-Users] Random Zap port going crazy When channel released
after a flash.
Dennis Walker
dwalker at jackson-tube.com
Wed Mar 8 15:42:37 MST 2006
On 1.2.x I have a random problem when a Zap/x channel flashes to transfer
or make a three way call.
The Zap/x-2 channel is created and the transfer or three way proceeds, but
on hangup the Zap/x-1 channel fails to destroy the old bridge and asterisk
goes crazy logging the problem. Here is an example debug log.
This happens only once a day or so, with 100 or so users transfering and
three way calling all the time.
Anyone having a simular problem.
Thanks for you help
Mar 7 11:21:29 VERBOSE[8204] logger.c: -- Starting simple switch on
'Zap/99-1'
Mar 7 11:21:31 DEBUG[8204] chan_zap.c: DTMF digit: 8 on Zap/99-1
Mar 7 11:21:32 DEBUG[8204] chan_zap.c: DTMF digit: 3 on Zap/99-1
Mar 7 11:21:32 DEBUG[8204] chan_zap.c: DTMF digit: 3 on Zap/99-1
Mar 7 11:21:33 DEBUG[8204] chan_zap.c: DTMF digit: 5 on Zap/99-1
Mar 7 11:21:33 DEBUG[8204] chan_zap.c: DTMF digit: 6 on Zap/99-1
Mar 7 11:21:33 DEBUG[8204] chan_zap.c: DTMF digit: 8 on Zap/99-1
Mar 7 11:21:33 DEBUG[8204] chan_zap.c: DTMF digit: 6 on Zap/99-1
Mar 7 11:21:34 DEBUG[8204] chan_zap.c: DTMF digit: 8 on Zap/99-1
Mar 7 11:21:34 DEBUG[8204] chan_zap.c: Enabled echo cancellation on
channel 99
Mar 7 11:21:34 VERBOSE[8204] logger.c: -- Executing
SetCallerID("Zap/99-1", "9377738550") in new stack
Mar 7 11:21:34 VERBOSE[8204] logger.c: -- Executing
SetCallerPres("Zap/99-1", "allowed") in new stack
Mar 7 11:21:34 VERBOSE[8204] logger.c: -- Executing Dial("Zap/99-1",
"Zap/G1/9373356868||Wg") in new stack
Mar 7 11:21:34 VERBOSE[8204] logger.c: -- Requested transfer
capability: 0x00 - SPEECH
Mar 7 11:21:34 DEBUG[25354] channel.c: Avoiding initial deadlock for
'Zap/22-1'
Mar 7 11:21:34 VERBOSE[8204] logger.c: -- Called G1/9373356868
Mar 7 11:21:34 DEBUG[25368] chan_zap.c: Queuing frame from
PRI_EVENT_PROCEEDING on channel 0/22 span 1
Mar 7 11:21:34 VERBOSE[8204] logger.c: -- Zap/22-1 is proceeding
passing it to Zap/99-1
Mar 7 11:21:34 DEBUG[8204] chan_zap.c: Requested indication 15 on channel
Zap/99-1
Mar 7 11:21:34 DEBUG[8204] chan_zap.c: Received AST_CONTROL_PROCEEDING on
Zap/99-1
Mar 7 11:21:36 DEBUG[25368] chan_zap.c: Enabled echo cancellation on
channel 22
Mar 7 11:21:36 DEBUG[25354] channel.c: Avoiding initial deadlock for
'Zap/22-1'
Mar 7 11:21:36 VERBOSE[8204] logger.c: -- Zap/22-1 is ringing
Mar 7 11:21:36 DEBUG[8204] chan_zap.c: Requested indication 3 on channel
Zap/99-1
Mar 7 11:21:56 VERBOSE[8204] logger.c: -- Zap/22-1 answered Zap/99-1
Mar 7 11:21:56 DEBUG[8204] chan_zap.c: Requested indication -1 on channel
Zap/99-1
Mar 7 11:21:56 DEBUG[8204] chan_zap.c: Took Zap/99-1 off hook
Mar 7 11:21:56 VERBOSE[8204] logger.c: -- Attempting native bridge of
Zap/99-1 and Zap/22-1
Mar 7 11:22:03 DEBUG[8204] chan_zap.c: Exception on 145, channel 99
Mar 7 11:22:03 DEBUG[8204] chan_zap.c: Got event Wink/Flash(3) on channel
99 (index 0)
Mar 7 11:22:03 DEBUG[8204] chan_zap.c: Winkflash, index: 0, normal: 145,
callwait: -1, thirdcall: -1
Mar 7 11:22:03 DEBUG[8204] chan_zap.c: Already have a dsp on Zap/99-2?
Mar 7 11:22:03 DEBUG[8204] chan_zap.c: Swapping 2 and 0
Mar 7 11:22:03 DEBUG[8204] chan_zap.c: disabled echo cancellation on
channel 99
----> Mar 7 11:22:03 VERBOSE[8229] logger.c: -- Starting simple switch
on 'Zap/99-2'
Mar 7 11:22:03 VERBOSE[8204] logger.c: -- Started three way call on
channel 99
Mar 7 11:22:03 VERBOSE[8204] logger.c: -- Started music on hold, class
'default', on channel 'Zap/22-1'
Mar 7 11:22:03 DEBUG[8204] channel.c: Scheduling timer at 160 sample
intervals
Mar 7 11:22:03 DEBUG[8204] chan_zap.c: Updated conferencing on 99, with 0
conference users
Mar 7 11:22:03 DEBUG[8204] channel.c: Generator got voice, switching to
phase locked mode
Mar 7 11:22:03 DEBUG[8204] channel.c: Scheduling timer at 0 sample
intervals
Mar 7 11:22:03 DEBUG[8204] channel.c: Auto-deactivating generator
Mar 7 11:22:03 VERBOSE[8204] logger.c: -- Stopped music on hold on
Zap/22-1
Mar 7 11:22:03 DEBUG[8204] channel.c: Scheduling timer at 0 sample
intervals
----> Mar 7 11:22:04 DEBUG[8229] chan_zap.c: DTMF digit: 8 on Zap/99-2
Mar 7 11:22:05 DEBUG[8229] chan_zap.c: DTMF digit: 3 on Zap/99-2
Mar 7 11:22:05 DEBUG[8229] chan_zap.c: DTMF digit: 3 on Zap/99-2
Mar 7 11:22:05 DEBUG[8229] chan_zap.c: DTMF digit: 5 on Zap/99-2
Mar 7 11:22:05 DEBUG[8229] chan_zap.c: DTMF digit: 6 on Zap/99-2
Mar 7 11:22:06 DEBUG[8229] chan_zap.c: DTMF digit: 8 on Zap/99-2
Mar 7 11:22:06 DEBUG[8229] chan_zap.c: DTMF digit: 6 on Zap/99-2
Mar 7 11:22:06 DEBUG[8229] chan_zap.c: DTMF digit: 8 on Zap/99-2
Mar 7 11:22:06 DEBUG[8229] chan_zap.c: Enabled echo cancellation on
channel 99
Mar 7 11:22:06 VERBOSE[8229] logger.c: -- Executing
SetCallerID("Zap/99-2", "9377738550") in new stack
Mar 7 11:22:06 VERBOSE[8229] logger.c: -- Executing
SetCallerPres("Zap/99-2", "allowed") in new stack
Mar 7 11:22:06 VERBOSE[8229] logger.c: -- Executing Dial("Zap/99-2",
"Zap/G1/9373356868||Wg") in new stack
Mar 7 11:22:06 VERBOSE[8229] logger.c: -- Requested transfer
capability: 0x00 - SPEECH
Mar 7 11:22:06 VERBOSE[8229] logger.c: -- Called G1/9373356868
Mar 7 11:22:06 DEBUG[25368] chan_zap.c: Queuing frame from
PRI_EVENT_PROCEEDING on channel 0/21 span 1
Mar 7 11:22:06 VERBOSE[8229] logger.c: -- Zap/21-1 is proceeding
passing it to Zap/99-2
Mar 7 11:22:06 DEBUG[8229] chan_zap.c: Requested indication 15 on channel
Zap/99-2
Mar 7 11:22:06 DEBUG[8229] chan_zap.c: Received AST_CONTROL_PROCEEDING on
Zap/99-2
Mar 7 11:22:07 VERBOSE[8229] logger.c: -- Zap/21-1 is busy
Mar 7 11:22:07 DEBUG[8229] chan_zap.c: Set option AUDIO MODE, value:
ON(1) on Zap/21-1
Mar 7 11:22:07 DEBUG[8229] chan_zap.c: Hangup: channel: 21 index = 0,
normal = 45, callwait = -1, thirdcall = -1
Mar 7 11:22:07 DEBUG[8229] chan_zap.c: Not yet hungup... Calling hangup
once with icause, and clearing call
Mar 7 11:22:07 DEBUG[8229] chan_zap.c: disabled echo cancellation on
channel 21
Mar 7 11:22:07 DEBUG[8229] chan_zap.c: Set option TDD MODE, value: OFF(0)
on Zap/21-1
Mar 7 11:22:07 DEBUG[8229] chan_zap.c: Updated conferencing on 21, with 0
conference users
Mar 7 11:22:07 DEBUG[8229] chan_zap.c: Set option AUDIO MODE, value:
OFF(0) on Zap/21-1
Mar 7 11:22:07 DEBUG[8229] chan_zap.c: disabled echo cancellation on
channel 21
Mar 7 11:22:07 VERBOSE[8229] logger.c: -- Hungup 'Zap/21-1'
Mar 7 11:22:07 VERBOSE[8229] logger.c: == Everyone is busy/congested at
this time (1:1/0/0)
Mar 7 11:22:07 DEBUG[8229] app_dial.c: Exiting with DIALSTATUS=BUSY.
Mar 7 11:22:07 VERBOSE[8229] logger.c: -- Executing
Congestion("Zap/99-2", "") in new stack
Mar 7 11:22:07 DEBUG[8229] chan_zap.c: Requested indication 8 on channel
Zap/99-2
Mar 7 11:22:10 DEBUG[8229] chan_zap.c: Exception on 145, channel 99
Mar 7 11:22:10 DEBUG[8229] chan_zap.c: Got event On hook(1) on channel 99
(index 0)
Mar 7 11:22:10 DEBUG[8229] chan_zap.c: Last flash was 6994 ms ago
Mar 7 11:22:10 DEBUG[8229] channel.c: Planning to masquerade channel
Zap/22-1 into the structure of Zap/99-2
Mar 7 11:22:10 DEBUG[8229] channel.c: Done planning to masquerade channel
Zap/22-1 into the structure of Zap/99-2
Mar 7 11:22:10 DEBUG[8229] chan_zap.c: Swapping 2 and 0
Mar 7 11:22:10 DEBUG[8229] chan_zap.c: Released sub 2 of channel 99
Mar 7 11:22:10 DEBUG[8229] channel.c: Got clone lock for masquerade on
'Zap/22-1' at 0x829a05c
Mar 7 11:22:10 DEBUG[8229] chan_zap.c: New owner for channel 99 is
Zap/22-1<MASQ>
Mar 7 11:22:10 DEBUG[8229] chan_zap.c: Updated conferencing on 99, with 0
conference users
Mar 7 11:22:10 DEBUG[8229] chan_zap.c: Hangup: channel: 99 index = -1,
normal = 145, callwait = -1, thirdcall = -1
Mar 7 11:22:10 VERBOSE[8229] logger.c: -- Hungup 'Zap/22-1<MASQ>'
Mar 7 11:22:10 DEBUG[8229] channel.c: Putting channel Zap/22-1 in 64/64
formats
Mar 7 11:22:10 DEBUG[8229] chan_zap.c: New owner for channel 22 is
Zap/22-1
Mar 7 11:22:10 DEBUG[8229] chan_zap.c: Updated conferencing on 22, with 0
conference users
Mar 7 11:22:10 DEBUG[8229] chan_zap.c: Updated conferencing on 22, with 0
conference users
Mar 7 11:22:10 DEBUG[8229] channel.c: Released clone lock on
'Zap/99-2<ZOMBIE>'
Mar 7 11:22:10 DEBUG[8229] channel.c: Done Masquerading Zap/22-1 (6)
Mar 7 11:22:10 DEBUG[8204] channel.c: Bridge stops because we're zombie or
need a soft hangup: c0=Zap/99-1, c1=Zap/99-2<ZOM
BIE>, flags: No,No,Yes,Yes
Mar 7 11:22:10 DEBUG[8204] channel.c: Bridge stops bridging channels
Zap/99-1 and Zap/99-2<ZOMBIE>
Mar 7 11:22:10 DEBUG[8204] app_dial.c: Exiting with DIALSTATUS=ANSWER.
Mar 7 11:22:10 VERBOSE[8204] logger.c: -- Executing
Congestion("Zap/99-1", "") in new stack
Mar 7 11:22:10 DEBUG[8204] chan_zap.c: Requested indication 8 on channel
Zap/99-1
Mar 7 11:22:11 DEBUG[8204] chan_zap.c: Exception on 145, channel 99
Mar 7 11:22:11 WARNING[8204] chan_zap.c: We're Zap/99-1, not
^F^X<AD><ZOMBIE>
Mar 7 11:22:11 DEBUG[8204] chan_zap.c: Exception on 145, channel 99
Mar 7 11:22:11 WARNING[8204] chan_zap.c: We're Zap/99-1, not
^F^X<AD><ZOMBIE>
Mar 7 11:22:11 DEBUG[8204] chan_zap.c: Exception on 145, channel 99
Mar 7 11:22:11 WARNING[8204] chan_zap.c: We're Zap/99-1, not
^F^X<AD><ZOMBIE>
Mar 7 11:22:11 DEBUG[8204] chan_zap.c: Exception on 145, channel 99
Mar 7 11:22:11 WARNING[8204] chan_zap.c: We're Zap/99-1, not
^F^X<AD><ZOMBIE>
Mar 7 11:22:11 DEBUG[8204] chan_zap.c: Exception on 145, channel 99
Mar 7 11:22:11 WARNING[8204] chan_zap.c: We're Zap/99-1, not
^F^X<AD><ZOMBIE>
Mar 7 11:22:11 DEBUG[8204] chan_zap.c: Exception on 145, channel 99
Mar 7 11:22:11 WARNING[8204] chan_zap.c: We're Zap/99-1, not
^F^X<AD><ZOMBIE>
Mar 7 11:22:11 DEBUG[8204] chan_zap.c: Exception on 145, channel 99
Mar 7 11:22:11 WARNING[8204] chan_zap.c: We're Zap/99-1, not
^F^X<AD><ZOMBIE>
Mar 7 11:22:11 DEBUG[8204] chan_zap.c: Exception on 145, channel 99
Mar 7 11:22:11 WARNING[8204] chan_zap.c: We're Zap/99-1, not
^F^X<AD><ZOMBIE>
Mar 7 11:22:11 DEBUG[8204] chan_zap.c: Exception on 145, channel 99
Mar 7 11:22:11 WARNING[8204] chan_zap.c: We're Zap/99-1, not
^F^X<AD><ZOMBIE>
Mar 7 11:22:11 DEBUG[8204] chan_zap.c: Exception on 145, channel 99
Mar 7 11:22:11 WARNING[8204] chan_zap.c: We're Zap/99-1, not
^F^X<AD><ZOMBIE>
Mar 7 11:22:11 DEBUG[8204] chan_zap.c: Exception on 145, channel 99
Mar 7 11:22:11 WARNING[8204] chan_zap.c: We're Zap/99-1, not
^F^X<AD><ZOMBIE>
Mar 7 11:22:11 DEBUG[8204] chan_zap.c: Exception on 145, channel 99
Mar 7 11:22:11 WARNING[8204] chan_zap.c: We're Zap/99-1, not
^F^X<AD><ZOMBIE>
Mar 7 11:22:11 DEBUG[8204] chan_zap.c: Exception on 145, channel 99
Mar 7 11:22:11 WARNING[8204] chan_zap.c: We're Zap/99-1, not
^F^X<AD><ZOMBIE>
Mar 7 11:22:11 DEBUG[8204] chan_zap.c: Exception on 145, channel 99
More information about the asterisk-users
mailing list