[asterisk-dev] iax2 native bridging drops transferred calls
repeatably
Thomas Andrews
tandrews at grok.co.za
Sun Aug 27 07:59:29 MST 2006
On Sun, Aug 27, 2006 at 09:13:01AM -0500, Kevin P. Fleming wrote:
> ----- Thomas Andrews <tandrews at grok.co.za> wrote:
> > It would seem to me that the code should pre-check if there is
> > already a native bridge in place, and if so take some action. What,
> > I don't know.
>
> This should not be necessary.
>
> Your description is slightly inaccurate, in that you undercounted the
> channels involved. When the two FXS phones on server A are talking to
> each other, there are four channels involved... two Zap, and two IAX2.
> In an ideal world Asterisk would drop these IAX2 channels completely
> since they are connected to each other, but that does not happen
> today.
>
> When one of the phones starts a transfer operation to the phone on
> server B, there are then six channels involved: three IAX2, and three
> Zap (two of which are on the same phone). When the transfer operation
> is completed, one of the IAX2 channels from the original bridge will
> be pulled out via masquerading and dropped into the new bridge with
> the IAX2 channel going to server B. This will then cause the remaining
> IAX2 channel and two Zap channels from the original call to be hung
> up.
>
> If this is not happening, then it's a bug, and we need a console and
> IAX2 debug trace on bugs.digium.com to work on it.
Thanks Kevin, I have a better understanding of it now that I've been
using Ethereal to trace what's going on. I've switched on iax debugging,
but there's such a lot of output that it will take me a little while
before I can post something of a reasonable size to Mantis. For what
it's worth, here's a stripped-down list of packets captured by Ethereal.
Things start to go wrong after packet 77. What I can't understand is why
TXCNT is getting four times (not two), and also why there are only three
occurrences of TXACC there...
Time Source Dest Info
1 0.000000 10.1.1.15 10.1.1.20 IAX, source call# 1, timestamp 7ms HANGUP
2 0.000709 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 8ms NEW
3 0.000790 10.1.1.20 10.1.1.15 IAX, source call# 0, timestamp 0ms INVAL
4 0.003165 10.1.1.20 10.1.1.15 IAX, source call# 1, timestamp 17ms AUTHREQ
5 0.003239 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 11ms AUTHREP
6 0.005289 10.1.1.20 10.1.1.15 IAX, source call# 1, timestamp 18ms ACCEPT
7 0.005439 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 18ms ACK
8 0.030273 10.1.1.20 10.1.1.15 IAX, source call# 1, timestamp 40ms ACK
9 0.261882 10.1.1.20 10.1.1.15 Control, source call# 1, timestamp 275ms RINGING
10 0.261905 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 275ms ACK
11 3.153526 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 3165ms ACK
12 3.153872 10.1.1.20 10.1.1.15 Control, source call# 1, timestamp 3168ms ANSWER
13 3.153900 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 3168ms ACK
14 3.166469 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 3180ms ACK
15 7.982808 10.1.1.20 10.1.1.15 IAX, source call# 2, timestamp 17ms HANGUP
16 7.982865 10.1.1.15 10.1.1.20 IAX, source call# 0, timestamp 0ms INVAL
17 7.994427 10.1.1.20 10.1.1.15 IAX, source call# 3, timestamp 8ms NEW
18 7.994550 10.1.1.15 10.1.1.20 IAX, source call# 3, timestamp 2ms AUTHREQ
19 7.998299 10.1.1.20 10.1.1.15 IAX, source call# 3, timestamp 12ms AUTHREP
20 7.998472 10.1.1.15 10.1.1.20 IAX, source call# 3, timestamp 6ms ACCEPT
21 8.000173 10.1.1.20 10.1.1.15 IAX, source call# 3, timestamp 6ms ACK
22 8.013424 10.1.1.15 10.1.1.20 IAX, source call# 3, timestamp 40ms ACK
23 8.034711 10.1.1.15 10.1.1.20 Control, source call# 3, timestamp 9ms RINGING
24 8.035151 10.1.1.20 10.1.1.15 IAX, source call# 3, timestamp 9ms ACK
25 9.670907 10.1.1.20 10.1.1.15 Control, source call# 1, timestamp 9663ms RINGING
26 9.670926 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 9663ms ACK
27 10.000126 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 10023ms LAGRQ
28 10.000830 10.1.1.20 10.1.1.15 IAX, source call# 1, timestamp 10023ms LAGRP
29 10.000852 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 10023ms ACK
30 10.001830 10.1.1.20 10.1.1.15 IAX, source call# 1, timestamp 10002ms LAGRQ
31 10.001860 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 10002ms LAGRP
32 10.002330 10.1.1.20 10.1.1.15 IAX, source call# 1, timestamp 10002ms ACK
33 10.798498 10.1.1.15 10.1.1.20 Control, source call# 3, timestamp 2806ms stop sounds
34 10.798510 10.1.1.15 10.1.1.20 Control, source call# 3, timestamp 2809ms ANSWER
35 10.798971 10.1.1.20 10.1.1.15 IAX, source call# 3, timestamp 2806ms ACK
36 10.799220 10.1.1.20 10.1.1.15 IAX, source call# 3, timestamp 2809ms ACK
37 10.802841 10.1.1.20 10.1.1.15 Control, source call# 1, timestamp 10799ms stop sounds
38 10.802858 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 10799ms ACK
39 10.803091 10.1.1.20 10.1.1.15 IAX, source call# 1, timestamp 10801ms TXREQ
40 10.803136 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 10801ms ACK
41 10.803155 10.1.1.15 10.1.1.15 IAX, source call# 2, timestamp 10823ms TXCNT
42 10.803216 10.1.1.20 10.1.1.15 IAX, source call# 3, timestamp 2823ms TXREQ
43 10.803238 10.1.1.15 10.1.1.20 IAX, source call# 3, timestamp 2823ms ACK
44 10.803246 10.1.1.15 10.1.1.15 IAX, source call# 3, timestamp 2811ms TXCNT
45 10.803266 10.1.1.15 10.1.1.15 IAX, source call# 2, timestamp 10824ms TXACC
46 10.803288 10.1.1.15 10.1.1.20 IAX, source call# 3, timestamp 2814ms TXREADY
47 10.804340 10.1.1.20 10.1.1.15 IAX, source call# 3, timestamp 2814ms ACK
48 10.814711 10.1.1.20 10.1.1.15 IAX, source call# 3, timestamp 2840ms ACK
49 12.802406 10.1.1.15 10.1.1.15 IAX, source call# 2, timestamp 10823ms TXCNT
50 12.802418 10.1.1.15 10.1.1.15 IAX, source call# 2, timestamp 10824ms TXACC
51 12.802453 10.1.1.15 10.1.1.15 IAX, source call# 3, timestamp 4828ms TXACC
52 12.802481 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 12823ms TXREADY
53 12.803749 10.1.1.20 10.1.1.15 IAX, source call# 1, timestamp 12808ms TXREL
54 12.803770 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 12808ms ACK
55 12.803999 10.1.1.20 10.1.1.15 IAX, source call# 3, timestamp 4824ms TXREL
56 12.804015 10.1.1.15 10.1.1.20 IAX, source call# 3, timestamp 4824ms ACK
57 12.813930 10.1.1.15 10.1.1.15 IAX, source call# 2, timestamp 1ms ACK
58 12.818892 10.1.1.15 10.1.1.15 IAX, source call# 3, timestamp 6ms ACK
59 17.811260 10.1.1.15 10.1.1.20 IAX, source call# 4, timestamp 19ms HANGUP
60 17.811953 10.1.1.20 10.1.1.15 IAX, source call# 0, timestamp 0ms INVAL
61 17.811980 10.1.1.15 10.1.1.20 IAX, source call# 5, timestamp 19ms NEW
62 17.814453 10.1.1.20 10.1.1.15 IAX, source call# 4, timestamp 9ms AUTHREQ
63 17.814539 10.1.1.15 10.1.1.20 IAX, source call# 5, timestamp 22ms AUTHREP
64 17.817573 10.1.1.20 10.1.1.15 IAX, source call# 4, timestamp 12ms ACCEPT
65 17.817725 10.1.1.15 10.1.1.20 IAX, source call# 5, timestamp 12ms ACK
66 17.834564 10.1.1.20 10.1.1.15 IAX, source call# 4, timestamp 40ms ACK
67 18.076909 10.1.1.20 10.1.1.15 Control, source call# 4, timestamp 270ms RINGING
68 18.076929 10.1.1.15 10.1.1.20 IAX, source call# 5, timestamp 270ms ACK
69 20.808143 10.1.1.15 10.1.1.15 Control, source call# 3, timestamp 8003ms RINGING
70 20.808165 10.1.1.15 10.1.1.15 IAX, source call# 2, timestamp 8003ms ACK
71 23.078499 10.1.1.20 10.1.1.15 Control, source call# 4, timestamp 5271ms stop sounds
72 23.078521 10.1.1.15 10.1.1.20 IAX, source call# 5, timestamp 5271ms ACK
73 23.078691 10.1.1.15 10.1.1.15 Control, source call# 3, timestamp 10273ms stop sounds
74 23.078708 10.1.1.15 10.1.1.15 IAX, source call# 2, timestamp 10273ms ACK
75 23.078749 10.1.1.20 10.1.1.15 Control, source call# 4, timestamp 5274ms ANSWER
76 23.078845 10.1.1.15 10.1.1.20 IAX, source call# 5, timestamp 5274ms ACK
77 23.079089 10.1.1.15 10.1.1.15 IAX, source call# 3, timestamp 10276ms TXREQ
78 23.079100 10.1.1.15 10.1.1.20 IAX, source call# 5, timestamp 5282ms TXREQ
79 23.079127 10.1.1.15 10.1.1.15 IAX, source call# 2, timestamp 10276ms ACK
80 23.079151 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 10267ms TXCNT
81 23.079998 10.1.1.20 10.1.1.15 IAX, source call# 4, timestamp 5282ms ACK
82 23.080372 10.1.1.20 10.1.1.15 IAX, source call# 4, timestamp 5275ms TXCNT
83 23.080401 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 10269ms TXACC
84 23.082933 10.1.1.15 10.1.1.20 IAX, source call# 5, timestamp 5280ms ACK
85 25.078415 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 10267ms TXCNT
86 25.078906 10.1.1.20 10.1.1.15 IAX, source call# 4, timestamp 7276ms TXACC
87 25.078943 10.1.1.15 10.1.1.15 IAX, source call# 2, timestamp 12268ms TXREADY
88 25.079030 10.1.1.15 10.1.1.15 IAX, source call# 3, timestamp 12268ms ACK
89 25.081904 10.1.1.20 10.1.1.15 IAX, source call# 4, timestamp 5275ms TXCNT
90 25.081937 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 12271ms TXACC
91 25.083279 10.1.1.20 10.1.1.15 IAX, source call# 4, timestamp 7283ms TXREADY
92 25.083402 10.1.1.15 10.1.1.20 IAX, source call# 5, timestamp 7286ms TXREL
93 25.083411 10.1.1.15 10.1.1.15 IAX, source call# 3, timestamp 12283ms TXREL
94 25.083424 10.1.1.15 10.1.1.15 IAX, source call# 2, timestamp 12283ms ACK
95 25.083778 10.1.1.20 10.1.1.15 IAX, source call# 4, timestamp 7286ms ACK
96 25.097395 10.1.1.20 10.1.1.15 IAX, source call# 4, timestamp 4ms ACK
97 25.102852 10.1.1.15 10.1.1.20 IAX, source call# 2, timestamp 17ms ACK
98 27.082596 10.1.1.15 10.1.1.20 IAX, source call# 5, timestamp 7286ms TXREL
99 27.083181 10.1.1.20 10.1.1.15 IAX, source call# 4, timestamp 0ms INVAL
Regards,
Thomas
More information about the asterisk-dev
mailing list