[Asterisk-Dev] hangup problem after dropping voice to long queue messages?

Fri Jan 30 09:14:52 MST 2004

If you ever see something like this happen, find someone on IRC who can
properly get you a backtrace on the deadlock to help us find it.

Mark

On Fri, 30 Jan 2004, Jonathan Biggs wrote:

> Just had a weird problem, Perhaps someone from
> development side may be able to determine if this a
> bug?  I will try to recreate this weekend
>
> Inbound IAX2 call transferred to ZAP channel got
> stuck.
> Seemed something in the hangup might not have worked
> right.
>
> Over 3000 messages saying Dropping voice to
> exceptionally long queue on
> IAX2[voicepulse at voicepulse-peer]/3
>
> Zap Channel Non Functional
>
> Show channels command showed active bridge
>
> iax2 show channels showed nothing
>
> Had to restart to clear
>
>
> Thanks for any help provided in advance
>
> Setup:
> Asterisk  from CVS-01/19/04-09:31:47
> 1 X100P
> 2 X full TDM400P
> Dual Pent III 600Mhz  RH9 smp  1 GB RAM
> IAX2 Service with voicepulse
>
> Have a long debug log file but will try and summarize
>
>
>
> End result:
> show channels shows call that really does not exist.
> (See Below)
> Zap Channel 4 Non-functional from handset
> iax2 show channels shows nothing.
> soft hangup - did nothing
> Zap destroy channel - did nothing
> had to restart asterisk to clear and restore Zap/4
>
>
> server*CLI> show channels
>         Channel  (Context    Extension    Pri )
> State Appl.         Data
>         Zap/4-1  (inside     s            1   )
> Up Bridged Call  IAX2[voicepulse at voicepulse-peer]/3
> IAX2[voicepulse at voicepulse-peer]/3  (outside    s
>       4   )      Up Dial
> Zap/2&Zap/3&Zap/4&Zap/5&Zap/6&Zap/7&Zap/8&Zap/9|25
>
> server*CLI> iax2 show channels
> Peer             Username    ID (Lo/Rem)  Seq (Tx/Rx)
> Lag      Jitter  Format
> 0 active IAX channel(s)
>
> Zap/1-1 X100P
> Zap/2-1 through 9-1 two TDM400P
>
> Debug log of events shows
>
> Call in on Zap/1-1
> Call Answered by Zap/7-1
> IAX2 call into Asterisk
> IAX2 call answered by Zap/4-1
> Wink flash on Zap/4-1
> Dial extension 105 for Zap/7-1
> Zap/7-1 hangup call on Zap/1-1
> Looks Like Zap/7-1 picked up call from Zap/4-2?
> Wink Flash on Channel 4
> Looks like Asterisk tried to transfer IAX2 call to
> Zap/7
> Next in log Dropping voice long queue messages 3079
> lines of this message over approx 1 minute.
> (See Below)
> Received hangup on IAX2 (I think)
> Zap Channel 4 non-functional from then on
>
> Next call in shows weird info on channel 4
> Last part of log
>
> Any ideas?
>
>
>
> (See Below)
>
>
>
> Jan 27 19:19:11 DEBUG[1236282160]: master: 4, slave:
> 7, nothingok: 0
> Jan 27 19:19:11 DEBUG[1236282160]: Stoping tones on
> 4/2 talking to 7/0
> Jan 27 19:19:11 DEBUG[1236282160]: Stoping tones on
> 7/0 talking to 4/2
> Jan 27 19:19:11 DEBUG[1236282160]: Making 7 slave to
> master 4 at 0
> Jan 27 19:19:11 DEBUG[1236282160]: Added 24 to
> conference 3848/1023
> Jan 27 19:19:11 DEBUG[1236282160]: Updated
> conferencing on 4, with 3 conference users
> Jan 27 19:19:11 DEBUG[1236282160]: Updated
> conferencing on 7, with 0 conference users
> Jan 27 19:19:12 DEBUG[1150528304]: Dropping voice to
> exceptionally long queue on
> IAX2[voicepulse at voicepulse-peer]/3
> Jan 27 19:19:12 DEBUG[1150528304]: Dropping voice to
> exceptionally long queue on
> IAX2[voicepulse at voicepulse-peer]/3
>
> (3076 OF THESE MESSAGES REMOVED)
>
> Jan 27 19:20:13 DEBUG[1150528304]: Dropping voice to
> exceptionally long queue on
> IAX2[voicepulse at voicepulse-peer]/3
> Jan 27 19:20:14 DEBUG[1150528304]: Immediately
> destroying 3, having received hangup
>
>
> LOG THAT SHOWS CHANNEL 4 ON NEXT CALL
> Jan 27 19:20:29 DEBUG[1236282160]: Hangup: channel: 5
> index = 0, normal = 21, callwait = -1, thirdcall = -1
> Jan 27 19:20:29 DEBUG[1236282160]: disabled echo
> cancellation on channel 5
> Jan 27 19:20:29 DEBUG[1236282160]: Set option TDD
> MODE, value: OFF(0) on Zap/5-1
> Jan 27 19:20:29 DEBUG[1236282160]: Updated
> conferencing on 5, with 0 conference users
> Jan 27 19:20:29 DEBUG[1236282160]: Hangup: channel: 4
> index = 1, normal = 22, callwait = 34, thirdcall = -1
> Jan 27 19:20:29 DEBUG[1236282160]: Released sub 1 of
> channel 4
> Jan 27 19:20:29 DEBUG[1236282160]: Hangup: channel: 3
> index = 0, normal = 20, callwait = -1, thirdcall = -1
> Jan 27 19:20:29 DEBUG[1236282160]: disabled echo
> cancellation on channel 3
> Jan 27 19:20:29 DEBUG[1236282160]: Set option TDD
> MODE, value: OFF(0) on Zap/3-1
> Jan 27 19:20:29 DEBUG[1236282160]: Updated
> conferencing on 3, with 0 conference users
>
>
> __________________________________
> Do you Yahoo!?
> Yahoo! SiteBuilder - Free web site building tool. Try it!
> http://webhosting.yahoo.com/ps/sb/
> _______________________________________________
> Asterisk-Dev mailing list
> Asterisk-Dev at lists.digium.com
> http://lists.digium.com/mailman/listinfo/asterisk-dev
> To UNSUBSCRIBE or update options visit:
>    http://lists.digium.com/mailman/listinfo/asterisk-dev
>