[asterisk-users] One PRI card with 2 (or more) Telcos

Andrew Latham lathama at gmail.com
Fri Mar 18 13:19:45 CDT 2011


On Fri, Mar 18, 2011 at 3:15 PM, Tiago Geada <tiago.geada at gmail.com> wrote:
> Just a follow up with a bit more information
>
> asterisk*CLI> module show like timing
> Module                         Description                              Use
> Count
> res_timing_pthread.so          pthread Timing Interface                 0
>
> res_timing_dahdi.so            DAHDI Timing Interface                   40
>
> 2 modules loaded
> asterisk*CLI>
>
> --
>
>  [root at asterisk ~]# dahdi_test -c 100
>
> Opened pseudo dahdi interface, measuring accuracy...
>
> 99.999% 99.999% 99.992% 99.997% 99.998% 99.995% 99.998% 99.996%
>
> 99.997% 99.998% 99.997% 99.994% 99.991% 99.999% 99.998% 99.998%
>
> 99.995% 99.993% 99.998% 99.999% 99.998% 99.995% 99.992% 99.998%
>
> 100.000% 99.998% 99.995% 99.992% 99.999% 99.998% 99.998% 99.999%
>
> 99.995% 99.999% 99.999% 99.998% 99.999% 99.997% 99.999% 99.998%
>
> 99.998% 99.996% 99.992% 99.998% 99.998% 99.999% 99.996% 99.992%
>
> 99.999% 99.998% 99.997% 99.997% 99.997% 99.998% 99.995% 99.994%
>
> 99.995% 99.992% 99.999% 99.993% 99.990% 99.995% 99.993% 99.999%
>
> 99.997% 99.993% 99.999% 99.996% 99.998% 99.996% 99.993% 99.995%
>
> 99.992% 99.998% 99.993% 99.993% 99.999% 99.993% 99.998% 99.996%
>
> 99.993% 99.996% 99.996% 99.994% 99.999% 99.996% 99.996% 99.992%
>
> 99.999% 99.996% 99.991% 99.996% 99.992% 99.998% 99.997% 99.994%
>
> 99.998% 99.995%
>
> --- Results after 98 passes ---
>
> Best: 100.000 -- Worst: 99.990 -- Average: 99.996163, Difference: 99.998235
>
> --
>
>  [root at asterisk ~]# cat
> /sys/devices/system/clocksource/clocksource0/current_clocksource
> tsc
>  [root at asterisk ~]# cat
> /sys/devices/system/clocksource/clocksource0/available_clocksource
> tsc hpet acpi_pm jiffies
>
> On 18 March 2011 17:52, Tiago Geada <tiago.geada at gmail.com> wrote:
>>
>> Hi list!
>> We currently have a PRI gateway composed by a box with two Digium
>> quad-span PRI cards (a TE420 and a ).
>> One of the cards is filled with TELCO1, while the other has first two
>> slots filled with TELCO2, and 3rd slot with TELCO3.
>> I am currently having (timer ?) issues on TELCO3 (span 7)
>> D-Chan (202 as determined by dahdi_genconf ) is constantly failing causing
>> on-going calls to terminate.
>> Problem clears immediately tho. I send a copy of the log with pri debug at
>> a time of problems...
>> Is there a problem having 2 telcos on the same PRI card?
>> Would somebody help?
>>
>> asterisk*CLI> pri show span 7
>> Primary D-channel: 202
>> Status: Provisioned, Up, Active
>> Switchtype: EuroISDN
>> Type: CPE
>> Overlap Dial: 0
>> Logical Channel Mapping: 0
>> Timer and counter settings:
>>   N200: 3
>>   N202: 3
>>   K: 7
>>   T200: 1000
>>   T202: 10000
>>   T203: 10000
>>   T303: 4000
>>   T305: 30000
>>   T308: 4000
>>   T309: 6000
>>   T313: 4000
>>   T-HOLD: 4000
>>   T-RETRIEVE: 4000
>>   T-RESPONSE: 4000
>> Overlap Recv: No
>>
>> and
>>
>> [Mar 18 17:04:05] VERBOSE[19844] chan_dahdi.c: TEI=0 MDL-ERROR (I): T200
>> expired N200 times sending RR/RNR in state 8(Timer recovery)
>> [Mar 18 17:04:05] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:05] VERBOSE[19844] chan_dahdi.c: Changing from state 8(Timer
>> recovery) to 5(Awaiting establishment)
>> [Mar 18 17:04:06] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:07] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:08] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:09] VERBOSE[19844] chan_dahdi.c: TEI=0 MDL-ERROR (G): T200
>> expired N200 times sending SABME in state 5(Awaiting establishment)
>> [Mar 18 17:04:09] VERBOSE[19844] chan_dahdi.c: Changing from state
>> 5(Awaiting establishment) to 4(TEI assigned)
>> [Mar 18 17:04:09] VERBOSE[19844] chan_dahdi.c: TEI=0 DL event:
>> Q931_DL_EVENT_DL_RELEASE_IND(3)
>> [Mar 18 17:04:09] VERBOSE[19844] chan_dahdi.c: Start T309 for call cref=56
>> on channel 2
>> [Mar 18 17:04:09] VERBOSE[19844] chan_dahdi.c: Start T309 for call cref=64
>> on channel 3
>> [Mar 18 17:04:09] VERBOSE[19844] chan_dahdi.c: Start T309 for call cref=58
>> on channel 4
>> [Mar 18 17:04:09] VERBOSE[19844] chan_dahdi.c: Start T309 for call cref=66
>> on channel 6
>> [Mar 18 17:04:09] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:09] VERBOSE[19844] chan_dahdi.c: Changing from state 4(TEI
>> assigned) to 5(Awaiting establishment)
>> [Mar 18 17:04:09] VERBOSE[19844] chan_dahdi.c:   == Primary D-Channel on
>> span 7 down
>> [Mar 18 17:04:09] WARNING[19844] chan_dahdi.c: No D-channels available!
>>  Using Primary channel 202 as D-channel anyway!
>> [Mar 18 17:04:10] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:11] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:12] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:13] VERBOSE[19844] chan_dahdi.c: TEI=0 MDL-ERROR (G): T200
>> expired N200 times sending SABME in state 5(Awaiting establishment)
>> [Mar 18 17:04:13] VERBOSE[19844] chan_dahdi.c: Changing from state
>> 5(Awaiting establishment) to 4(TEI assigned)
>> [Mar 18 17:04:13] VERBOSE[19844] chan_dahdi.c: TEI=0 DL event:
>> Q931_DL_EVENT_DL_RELEASE_IND(3)
>> [Mar 18 17:04:13] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:13] VERBOSE[19844] chan_dahdi.c: Changing from state 4(TEI
>> assigned) to 5(Awaiting establishment)
>> [Mar 18 17:04:13] WARNING[19844] chan_dahdi.c: No D-channels available!
>>  Using Primary channel 202 as D-channel anyway!
>> [Mar 18 17:04:14] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c: T309 timed out waiting for
>> data link re-establishment
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c: q931.c:7750
>> pri_internal_clear: Call 56 enters state 0 (Null).  Hold state: Idle
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c: clearing, alive 1,
>> hangupack 0
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c:   == Primary D-Channel on
>> span 7 up
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c:     -- Channel 0/2, span 7
>> got hangup, cause 27
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c: T309 timed out waiting for
>> data link re-establishment
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c: q931.c:7750
>> pri_internal_clear: Call 64 enters state 0 (Null).  Hold state: Idle
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c: clearing, alive 1,
>> hangupack 0
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c:     -- Channel 0/3, span 7
>> got hangup, cause 27
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c: T309 timed out waiting for
>> data link re-establishment
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c: q931.c:7750
>> pri_internal_clear: Call 58 enters state 0 (Null).  Hold state: Idle
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c: clearing, alive 1,
>> hangupack 0
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c:     -- Channel 0/4, span 7
>> got hangup, cause 27
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c: T309 timed out waiting for
>> data link re-establishment
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c: q931.c:7750
>> pri_internal_clear: Call 66 enters state 0 (Null).  Hold state: Idle
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c: clearing, alive 1,
>> hangupack 0
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c:     -- Channel 0/6, span 7
>> got hangup, cause 27
>> [Mar 18 17:04:15] VERBOSE[27353] pbx.c:   == Spawn extension
>> (incoming-pri, sw-30-218543080, 11) exited non-zero on 'DAHDI/189-1'
>> [Mar 18 17:04:15] VERBOSE[27353] chan_dahdi.c: q931_hangup: other hangup
>> [Mar 18 17:04:15] VERBOSE[27354] app_mixmonitor.c:   == MixMonitor close
>> filestream
>> [Mar 18 17:04:15] VERBOSE[27353] chan_dahdi.c: NEW_HANGUP DEBUG: Calling
>> q931_hangup, ourstate Null, peerstate Null, hold-state Idle
>> [Mar 18 17:04:15] VERBOSE[27353] chan_dahdi.c: NEW_HANGUP DEBUG:
>> Destroying the call, ourstate Null, peerstate Null, hold-state Idle
>> [Mar 18 17:04:15] VERBOSE[27353] chan_dahdi.c:     -- Hungup 'DAHDI/189-1'
>> [Mar 18 17:04:15] VERBOSE[27354] app_mixmonitor.c:   == Executing
>> [/usr/local/bin/mixmon "1300465595.27894_withhold.gsm"
>> "/var/log/asterisk/asterisk_rec/218543080/2011-03-18"]
>> [Mar 18 17:04:15] VERBOSE[27279] pbx.c:   == Spawn extension
>> (incoming-pri, sw-30-218543080, 11) exited non-zero on 'DAHDI/188-1'
>> [Mar 18 17:04:15] VERBOSE[27279] chan_dahdi.c: q931_hangup: other hangup
>> [Mar 18 17:04:15] VERBOSE[27279] chan_dahdi.c: NEW_HANGUP DEBUG: Calling
>> q931_hangup, ourstate Null, peerstate Null, hold-state Idle
>> [Mar 18 17:04:15] VERBOSE[27279] chan_dahdi.c: NEW_HANGUP DEBUG:
>> Destroying the call, ourstate Null, peerstate Null, hold-state Idle
>> [Mar 18 17:04:15] VERBOSE[27280] app_mixmonitor.c:   == MixMonitor close
>> filestream
>> [Mar 18 17:04:15] VERBOSE[27279] chan_dahdi.c:     -- Hungup 'DAHDI/188-1'
>> [Mar 18 17:04:15] VERBOSE[27280] app_mixmonitor.c:   == Executing
>> [/usr/local/bin/mixmon "1300465487.27876_219575683.gsm"
>> "/var/log/asterisk/asterisk_rec/218543080/2011-03-18"]
>> [Mar 18 17:04:15] VERBOSE[27954] pbx.c:   == Spawn extension
>> (incoming-pri, sw-30-218543080, 11) exited non-zero on 'DAHDI/192-1'
>> [Mar 18 17:04:15] VERBOSE[27955] app_mixmonitor.c:   == MixMonitor close
>> filestream
>> [Mar 18 17:04:15] VERBOSE[27954] chan_dahdi.c: q931_hangup: other hangup
>> [Mar 18 17:04:15] VERBOSE[27954] chan_dahdi.c: NEW_HANGUP DEBUG: Calling
>> q931_hangup, ourstate Null, peerstate Null, hold-state Idle
>> [Mar 18 17:04:15] VERBOSE[27954] chan_dahdi.c: NEW_HANGUP DEBUG:
>> Destroying the call, ourstate Null, peerstate Null, hold-state Idle
>> [Mar 18 17:04:15] VERBOSE[27954] chan_dahdi.c:     -- Hungup 'DAHDI/192-1'
>> [Mar 18 17:04:15] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:15] VERBOSE[27955] app_mixmonitor.c:   == Executing
>> [/usr/local/bin/mixmon "1300467477.28066_229959499.gsm"
>> "/var/log/asterisk/asterisk_rec/218543080/2011-03-18"]
>> [Mar 18 17:04:15] VERBOSE[27487] pbx.c:   == Spawn extension
>> (incoming-pri, sw-30-218543080, 11) exited non-zero on 'DAHDI/190-1'
>> [Mar 18 17:04:15] VERBOSE[27487] chan_dahdi.c: q931_hangup: other hangup
>> [Mar 18 17:04:15] VERBOSE[27488] app_mixmonitor.c:   == MixMonitor close
>> filestream
>> [Mar 18 17:04:15] VERBOSE[27487] chan_dahdi.c: NEW_HANGUP DEBUG: Calling
>> q931_hangup, ourstate Null, peerstate Null, hold-state Idle
>> [Mar 18 17:04:15] VERBOSE[27487] chan_dahdi.c: NEW_HANGUP DEBUG:
>> Destroying the call, ourstate Null, peerstate Null, hold-state Idle
>> [Mar 18 17:04:15] VERBOSE[27487] chan_dahdi.c:     -- Hungup 'DAHDI/190-1'
>> [Mar 18 17:04:15] VERBOSE[27488] app_mixmonitor.c:   == Executing
>> [/usr/local/bin/mixmon "1300466049.27932_263949634.gsm"
>> "/var/log/asterisk/asterisk_rec/218543080/2011-03-18"]
>> [Mar 18 17:04:16] VERBOSE[27280] app_mixmonitor.c:   == End MixMonitor
>> Recording DAHDI/188-1
>> [Mar 18 17:04:16] VERBOSE[27488] app_mixmonitor.c:   == End MixMonitor
>> Recording DAHDI/190-1
>> [Mar 18 17:04:16] VERBOSE[27354] app_mixmonitor.c:   == End MixMonitor
>> Recording DAHDI/189-1
>> [Mar 18 17:04:16] VERBOSE[27955] app_mixmonitor.c:   == End MixMonitor
>> Recording DAHDI/192-1
>> [Mar 18 17:04:16] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:17] VERBOSE[19844] chan_dahdi.c: TEI=0 MDL-ERROR (G): T200
>> expired N200 times sending SABME in state 5(Awaiting establishment)
>> [Mar 18 17:04:17] VERBOSE[19844] chan_dahdi.c: Changing from state
>> 5(Awaiting establishment) to 4(TEI assigned)
>> [Mar 18 17:04:17] VERBOSE[19844] chan_dahdi.c: TEI=0 DL event:
>> Q931_DL_EVENT_DL_RELEASE_IND(3)
>> [Mar 18 17:04:17] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:17] VERBOSE[19844] chan_dahdi.c: Changing from state 4(TEI
>> assigned) to 5(Awaiting establishment)
>> [Mar 18 17:04:17] VERBOSE[19844] chan_dahdi.c:   == Primary D-Channel on
>> span 7 down
>> [Mar 18 17:04:17] WARNING[19844] chan_dahdi.c: No D-channels available!
>>  Using Primary channel 202 as D-channel anyway!
>> [Mar 18 17:04:18] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:19] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:20] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:21] VERBOSE[19844] chan_dahdi.c: TEI=0 MDL-ERROR (G): T200
>> expired N200 times sending SABME in state 5(Awaiting establishment)
>> [Mar 18 17:04:21] VERBOSE[19844] chan_dahdi.c: Changing from state
>> 5(Awaiting establishment) to 4(TEI assigned)
>> [Mar 18 17:04:21] VERBOSE[19844] chan_dahdi.c: TEI=0 DL event:
>> Q931_DL_EVENT_DL_RELEASE_IND(3)
>> [Mar 18 17:04:21] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:21] VERBOSE[19844] chan_dahdi.c: Changing from state 4(TEI
>> assigned) to 5(Awaiting establishment)
>> [Mar 18 17:04:21] WARNING[19844] chan_dahdi.c: No D-channels available!
>>  Using Primary channel 202 as D-channel anyway!
>> [Mar 18 17:04:22] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:23] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:24] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:25] VERBOSE[19844] chan_dahdi.c: TEI=0 MDL-ERROR (G): T200
>> expired N200 times sending SABME in state 5(Awaiting establishment)
>> [Mar 18 17:04:25] VERBOSE[19844] chan_dahdi.c: Changing from state
>> 5(Awaiting establishment) to 4(TEI assigned)
>> [Mar 18 17:04:25] VERBOSE[19844] chan_dahdi.c: TEI=0 DL event:
>> Q931_DL_EVENT_DL_RELEASE_IND(3)
>> [Mar 18 17:04:25] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:25] VERBOSE[19844] chan_dahdi.c: Changing from state 4(TEI
>> assigned) to 5(Awaiting establishment)
>> [Mar 18 17:04:25] WARNING[19844] chan_dahdi.c: No D-channels available!
>>  Using Primary channel 202 as D-channel anyway!
>> [Mar 18 17:04:26] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:27] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>> [Mar 18 17:04:28] VERBOSE[19844] chan_dahdi.c: TEI=0 Sending SABME
>
>
> --
> _____________________________________________________________________
> -- Bandwidth and Colocation Provided by http://www.api-digital.com --
> New to Asterisk? Join us for a live introductory webinar every Thurs:
>               http://www.asterisk.org/hello
>
> asterisk-users mailing list
> To UNSUBSCRIBE or update options visit:
>   http://lists.digium.com/mailman/listinfo/asterisk-users
>

Tiago

Hardware interface cards like the cards from Digium are great at what
they do.  In this case you may want to look at some abstraction in the
form of a Redfone or other PRI terminating device.

There is no problem with having multiple providers. Having multiple
timing can be bad.

-- 
~~~ Andrew "lathama" Latham lathama at gmail.com ~~~



More information about the asterisk-users mailing list