Проблема с исходящими вызовами через E1

30 Aug 2011

#1 30.08.2011 14:01

Проблема с исходящими вызовами через E1

Имеем:
CentOS release 5.5 64 bit
Asterisk 1.6.2.19
libpri version: 1.4.11.3
DAHDI Version: 2.3.0.1
FreePBX version: 2.9.0.7

dahdi_scan

[1]
active=yes
alarms=OK
description=Wildcard TE121 Card 0
name=WCT1/0
manufacturer=Digium
devicetype=Wildcard TE121 (VPMADT032)
location=PCI Bus 11 Slot 09
basechan=1
totchans=31
irq=169
type=digital-E1
syncsrc=0
lbo=0 db (CSU)/0-133 feet (DSX-1)
coding_opts=HDB3
framing_opts=CCS,CRC4
coding=HDB3
framing=CCS

cat /etc/dahdi/system.conf

span=1,0,0,CCS,HDB3,CRC4
bchan=1-15,17-31
dchan=16
loadzone=ru
defaultzone=ru

cut /etc/asterisk/chan_dahdi.conf

; Copied from DAHDI Module of FreePBX

[general]

language=ru

; generated by module
#include chan_dahdi_general.conf

; for user additions not provided by module
#include chan_dahdi_general_custom.conf

[channels]

; for user additions not provided by module
#include chan_dahdi_channels_custom.conf

; include dahdi groups defined by DAHDI module of FreePBX
#include chan_dahdi_groups.conf

; include dahdi extensions defined in FreePBX
#include chan_dahdi_additional.conf

cat /etc/asterisk/chan_dahdi_channels_custom.conf

callerid=asreceived
usecallerid=yes
hidecallerid=no
callwaiting=yes
overlapdial=no
relaxdtmf=yes
usecallingpres=yes
callwaitingcallerid=yes
restrictcid=no
callprogress=yes
priindiction=iband
rxgain=0.0
txgain=0.0
threewaycalling=yes
faxdetect=incoming

cat /etc/asterisk/chan_dahdi_groups.conf

signalling=pri_cpe
switchtype=national
pridialplan=unknown
prilocaldialplan=national
group=1
context=from-pstn
channel=>1-15,17-31

>pri show span 1

Primary D-channel: 16
Status: Provisioned, Up, Active
Switchtype: National ISDN
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

Проблема в том, что исходящие звонки не работают.
Входящие - работают прекрасно.

Пров передал дословно следующее:

Quote:

calling party number (номер А)

1. Номер 10 цифр (495ХХХХХХХ) - тестовый
2. Numbering plan - ISDN/Telephony
3. Type of number - National

Called party number (номер В)

1. Numbering plan - ISDN/Telephony
2. Type of number - unknown

Сигнализация DSS1
Сигнальный канал - 16
CRC - выключено

отправка цифр енблоком

При исходящем звонке pri set debug 2 span 1 дает следующее (извините за размер):

=~=~=~=~=~=~=~=~=~=~=~= PuTTY log 2011.08.30 15:39:00 =~=~=~=~=~=~=~=~=~=~=~=

[0KTEI: 0 State 7
V(S) 17 V(A) 17 V(R) 31
K 7, RC 0, l3initiated 0, reject_except 0 ack_pend 0
T200 0, N200 3, T203 1

< [ 02 01 01 23 ]

< Supervisory frame:
< SAPI: 00 C/R: 1 EA: 0
< TEI: 000 EA: 1
< Zero: 0 S: 0 01: 1 [ RR (receive ready) ]
< N(R): 017 P/F: 1
< 0 bytes of data
Sending Receiver Ready (31)
TEI: 0 State 7
V(S) 17 V(A) 17 V(R) 31

[Kpbx*CLI>
[0KK 7, RC 0, l3initiated 0, reject_except 0 ack_pend 0

[Kpbx*CLI>
[0KT200 0, N200 3, T203 1

[Kpbx*CLI>
[0K

[Kpbx*CLI>
[0K> [ 02 01 01 3f ]

[Kpbx*CLI>
[0K

[Kpbx*CLI>
[0K> Supervisory frame:

[Kpbx*CLI>
[0K> SAPI: 00 C/R: 1 EA: 0

[Kpbx*CLI>
[0K> TEI: 000 EA: 1

[Kpbx*CLI>
[0K> Zero: 0 S: 0 01: 1 [ RR (receive ready) ]
> N(R): 031 P/F: 1
> 0 bytes of data
-- ACKing all packets from 17 to (but not including) 17
-- T200 requested to stop when not started
T203 requested to start without stopping first
-- Starting T203 timer
Handling message for SAPI/TEI=0/0

[Kpbx*CLI>
[0K == Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5

[Kpbx*CLI>
[0K -- Executing [55564318@from-internal:1] [1;36mMacro[0m("[1;35mSIP/626-0000006d[0m", "[1;35muser-callerid,LIMIT,[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-user-callerid:1] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mAMPUSER=626[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-user-callerid:2] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?report[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-user-callerid:3] [1;36mExecIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m1?Set(REALCALLERIDNUM=626)[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-user-callerid:4] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mAMPUSER=626[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-user-callerid:5] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mAMPUSERCIDNAME=Test[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-user-callerid:6] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?report[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-user-callerid:7] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mAMPUSERCID=626[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-user-callerid:8] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mCALLERID(all)="Test" [0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-user-callerid:9] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?limit[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-user-callerid:10] [1;36mExecIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m1?Set(GROUP(concurrency_limit)=626)[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-user-callerid:11] [1;36mExecIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?Set(CHANNEL(language)=)[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-user-callerid:12] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m1?continue[0m") in new stack

[Kpbx*CLI>
[0K -- Goto (macro-user-callerid,s,25)

[Kpbx*CLI>
[0K -- Executing [s@macro-user-callerid:25] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mCALLERID(number)=626[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-user-callerid:26] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mCALLERID(name)=Test[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [55564318@from-internal:2] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mMOHCLASS=default[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [55564318@from-internal:3] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35m_NODEST=[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [55564318@from-internal:4] [1;36mMacro[0m("[1;35mSIP/626-0000006d[0m", "[1;35mrecord-enable,626,OUT,[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-record-enable:1] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m1?check[0m") in new stack

[Kpbx*CLI>
[0K -- Goto (macro-record-enable,s,4)

[Kpbx*CLI>
[0K -- Executing [s@macro-record-enable:4] [1;36mExecIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?MacroExit()[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-record-enable:5] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?Group:OUT[0m") in new stack

[Kpbx*CLI>
[0K -- Goto (macro-record-enable,s,14)

[Kpbx*CLI>
[0K -- Executing [s@macro-record-enable:14] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?IN[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-record-enable:15] [1;36mExecIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m1?MacroExit()[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [55564318@from-internal:5] [1;36mMacro[0m("[1;35mSIP/626-0000006d[0m", "[1;35mdialout-trunk,6,5564318,[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-dialout-trunk:1] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mDIAL_TRUNK=6[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-dialout-trunk:2] [1;36mGosubIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?sub-pincheck,s,1[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-dialout-trunk:3] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?disabletrunk,1[0m") in new stack
-- Executing [s@macro-dialout-trunk:4] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mDIAL_NUMBER=5564318[0m") in new stack
-- Executing [s@macro-dialout-trunk:5] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mDIAL_TRUNK_OPTIONS=tr[0m") in new stack
-- Executing [s@macro-dialout-trunk:6] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mOUTBOUND_GROUP=OUT_6[0m") in new stack
-- Executing [s@macro-dialout-trunk:7] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m1?nomax[0m") in new stack
-- Goto (macro-dialout-trunk,s,9)
-- Executing [s@macro-dialout-trunk:9] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?skipoutcid[0m") in new stack
-- Executing [s@macro-dialout-trunk:10] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mDIAL_TRUNK_OPTIONS=[0m") in new stack
-- Executing [s@macro-dialout-trunk:11] [1;36mMacro[0m("[1;35mSIP/626-0000006d[0m", "[1;35moutbound-callerid,6[0m") in new stack
-- Executing [s@macro-outbound-callerid:1] [1;36mExecIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?Set(CALLERPRES()=)[0m") in new stack
-- Executing [s@macro-outbound-callerid:2] [1;36mExecIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?Set(REALCALLERIDNUM=626)[0m") in new stack
-- Executing [s@macro-outbound-callerid:3] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m1?normcid[0m") in new stack
-- Goto (macro-outbound-callerid,s,6)
-- Executing [s@macro-outbound-callerid:6] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mUSEROUTCID=[0m") in new stack
-- Executing [s@macro-outbound-callerid:7] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mEMERGENCYCID=[0m") in new stack
-- Executing [s@macro-outbound-callerid:8] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mTRUNKOUTCID=495XXXXXXX[0m") in new stack
-- Executing [s@macro-outbound-callerid:9] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m1?trunkcid[0m") in new stack
-- Goto (macro-outbound-callerid,s,12)
-- Executing [s@macro-outbound-callerid:12] [1;36mExecIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m1?Set(CALLERID(all)=495XXXXXXX)[0m") in new stack
-- Executing [s@macro-outbound-callerid:13] [1;36mExecIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?Set(CALLERID(all)=)[0m") in new stack
-- Executing [s@macro-outbound-callerid:14] [1;36mExecIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?Set(CALLERID(all)=)[0m") in new stack
-- Executing [s@macro-outbound-callerid:15] [1;36mExecIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?Set(CALLERPRES()=prohib_passed_screen)[0m") in new stack
-- Executing [s@macro-dialout-trunk:12] [1;36mGosubIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?sub-flp-6,s,1[0m") in new stack
-- Executing [s@macro-dialout-trunk:13] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mOUTNUM=5564318[0m") in new stack
-- Executing [s@macro-dialout-trunk:14] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mcustom=DAHDI/G1[0m") in new stack
-- Executing [s@macro-dialout-trunk:15] [1;36mExecIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))[0m") in new stack
-- Executing [s@macro-dialout-trunk:16] [1;36mExecIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?Set(DIAL_TRUNK_OPTIONS=M(confirm))[0m") in new stack
-- Executing [s@macro-dialout-trunk:17] [1;36mMacro[0m("[1;35mSIP/626-0000006d[0m", "[1;35mdialout-trunk-predial-hook,[0m") in new stack
-- Executing [s@macro-dialout-trunk-predial-hook:1] [1;36mMacroExit[0m("[1;35mSIP/626-0000006d[0m", "[1;35m[0m") in new stack
-- Executing [s@macro-dialout-trunk:18] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?bypass,1[0m") in new stack
-- Executing [s@macro-dialout-trunk:19] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?customtrunk[0m") in new stack
-- Executing [s@macro-dialout-trunk:20] [1;36mDial[0m("[1;35mSIP/626-0000006d[0m", "[1;35mDAHDI/G1/5564318,300,[0m") in new stack
-- Making new call for cref 32780
-- Requested transfer capability: 0x00 - SPEECH
-- Finally transmitting 0, since window opened up (7)
TEI: 0 State 7
V(S) 17 V(A) 17 V(R) 31
K 7, RC 0, l3initiated 0, reject_except 0 ack_pend 0
T200 0, N200 3, T203 1

> [ 00 01 22 3e 08 02 00 0c 05 04 03 80 90 a3 18 03 a1 83 9f 1e 02 80 83 6c 0c 21 80 34 39 35 32 38 30 37 33 37 33 70 08 80 35 35 36 34 33 31 38 ]

> Informational frame:
> SAPI: 00 C/R: 0 EA: 0
> TEI: 000 EA: 1
> N(S): 017 0: 0
> N(R): 031 P: 0
> 43 bytes of data
-- Stopping T203 timer
-- Starting T200 timer
> Protocol Discriminator: Q.931 ( Cool

len=43
> TEI=0 Call Ref: len= 2 (reference 12/0xC) (Sent from originator)
> Message Type: SETUP (5)
> [04 03 80 90 a3]
> Bearer Capability (len= 5) [ Ext: 1 Q.931 Std: 0 Info transfer capability: Speech (0)
> Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16)
> User information layer 1: A-Law (35)
> [18 03 a1 83 9f]
> Channel ID (len= 5) [ Ext: 1 IntID: Implicit Other(PRI) Spare: 0 Preferred Dchan: 0
> ChanSel: As indicated in following octets
> Ext: 1 Coding: 0 Number Specified Channel Type: 3
> Ext: 1 Channel: 31 Type: CPE]
> [1e 02 80 83]
> Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: User (0)
> Ext: 1 Progress Description: Calling equipment is non-ISDN. (3) ]
> [6c 0c 21 80 34 39 35 32 38 30 37 33 37 33]
> Calling Number (len=14) [ Ext: 0 TON: National Number (2) NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1)
> Presentation: Presentation permitted, user number not screened (0) '495XXXXXXX' ]
> [70 08 80 35 35 36 34 33 31 38]
> Called Number (len=10) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '5564318' ]
q931.c:4877 q931_setup: Call 32780 enters state 1 (Call Initiated). Hold state: Idle
-- Called G1/5564318

[Kpbx*CLI>
[0KTEI: 0 State 7
V(S) 18 V(A) 17 V(R) 31
K 7, RC 0, l3initiated 0, reject_except 0 ack_pend 0
T200 1, N200 3, T203 0

< [ 00 01 01 24 ]

< Supervisory frame:
< SAPI: 00 C/R: 0 EA: 0
< TEI: 000 EA: 1
< Zero: 0 S: 0 01: 1 [ RR (receive ready) ]
< N(R): 018 P/F: 0
< 0 bytes of data

[Kpbx*CLI>
[0K-- ACKing all packets from 17 to (but not including) 18
-- ACKing packet 17, new txqueue is -1 (-1 means empty)
-- Stopping T200 timer
-- Starting T203 timer

[Kpbx*CLI>
[0KHandling message for SAPI/TEI=0/0

[Kpbx*CLI>
[0KTEI: 0 State 7
V(S) 18 V(A) 18 V(R) 31
K 7, RC 0, l3initiated 0, reject_except 0 ack_pend 0
T200 0, N200 3, T203 1

< [ 02 01 3e 24 08 02 80 0c 0d 18 03 a9 83 9f ]

< Informational frame:
< SAPI: 00 C/R: 1 EA: 0
< TEI: 000 EA: 1
< N(S): 031 0: 0
< N(R): 018 P: 0
< 10 bytes of data
< Protocol Discriminator: Q.931 ( Cool

len=10
< TEI=0 Call Ref: len= 2 (reference 12/0xC) (Sent to originator)
< Message Type: SETUP ACKNOWLEDGE (13)
< [18 03 a9 83 9f]
< Channel ID (len= 5) [ Ext: 1 IntID: Implicit Other(PRI) Spare: 0 Exclusive Dchan: 0
< ChanSel: As indicated in following octets
< Ext: 1 Coding: 0 Number Specified Channel Type: 3
< Ext: 1 Channel: 31 Type: CPE]
Received message for call 0x19e38cf0 on 0x19a25b50 TEI/SAPI 0/0, call->pri is 0x19a25b50 TEI/SAPI 0/0
-- Processing IE 24 (cs0, Channel Identification)
q931.c:7194 post_handle_q931_message: Call 32780 enters state 2 (Overlap Sending). Hold state: Idle
-- ACKing all packets from 18 to (but not including) 18
-- T200 requested to stop when not started
T203 requested to start without stopping first
-- Starting T203 timer
Sending Receiver Ready (32)
TEI: 0 State 7
V(S) 18 V(A) 18 V(R) 32
K 7, RC 0, l3initiated 0, reject_except 0 ack_pend 0
T200 0, N200 3, T203 1

> [ 02 01 01 40 ]

> Supervisory frame:
> SAPI: 00 C/R: 1 EA: 0
> TEI: 000 EA: 1
> Zero: 0 S: 0 01: 1 [ RR (receive ready) ]
> N(R): 032 P/F: 0
> 0 bytes of data
Handling message for SAPI/TEI=0/0

[Kpbx*CLI>
[0KTEI: 0 State 7
V(S) 18 V(A) 18 V(R) 32
K 7, RC 0, l3initiated 0, reject_except 0 ack_pend 0
T200 0, N200 3, T203 1

< [ 02 01 40 24 08 02 80 0c 02 18 03 a9 83 9f ]

< Informational frame:
< SAPI: 00 C/R: 1 EA: 0
< TEI: 000 EA: 1
< N(S): 032 0: 0
< N(R): 018 P: 0
< 10 bytes of data
< Protocol Discriminator: Q.931 ( Cool

len=10
< TEI=0 Call Ref: len= 2 (reference 12/0xC) (Sent to originator)
< Message Type: CALL PROCEEDING (2)
< [18 03 a9 83 9f]
< Channel ID (len= 5) [ Ext: 1 IntID: Implicit Other(PRI) Spare: 0 Exclusive Dchan: 0
< ChanSel: As indicated in following octets
< Ext: 1 Coding: 0 Number Specified Channel Type: 3
< Ext: 1 Channel: 31 Type: CPE]
Received message for call 0x19e38cf0 on 0x19a25b50 TEI/SAPI 0/0, call->pri is 0x19a25b50 TEI/SAPI 0/0
-- Processing IE 24 (cs0, Channel Identification)
q931.c:6916 post_handle_q931_message: Call 32780 enters state 3 (Outgoing Call Proceeding). Hold state: Idle
-- ACKing all packets from 18 to (but not including) 18
-- T200 requested to stop when not started
T203 requested to start without stopping first
-- Starting T203 timer
Sending Receiver Ready (33)
TEI: 0 State 7
V(S) 18 V(A) 18 V(R) 33
K 7, RC 0, l3initiated 0, reject_except 0 ack_pend 0
T200 0, N200 3, T203 1

> [ 02 01 01 42 ]

> Supervisory frame:
> SAPI: 00 C/R: 1 EA: 0
> TEI: 000 EA: 1
> Zero: 0 S: 0 01: 1 [ RR (receive ready) ]
> N(R): 033 P/F: 0
> 0 bytes of data
Handling message for SAPI/TEI=0/0
-- DAHDI/31-1 is proceeding passing it to SIP/626-0000006d
TEI: 0 State 7
V(S) 18 V(A) 18 V(R) 33
K 7, RC 0, l3initiated 0, reject_except 0 ack_pend 0
T200 0, N200 3, T203 1

< [ 02 01 42 24 08 02 80 0c 45 08 02 80 9b ]

< Informational frame:
< SAPI: 00 C/R: 1 EA: 0
< TEI: 000 EA: 1
< N(S): 033 0: 0
< N(R): 018 P: 0
< 9 bytes of data
< Protocol Discriminator: Q.931 ( Cool

len=9
< TEI=0 Call Ref: len= 2 (reference 12/0xC) (Sent to originator)
< Message Type: DISCONNECT (69)
< [08 02 80 9b]
< Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: User (0)
< Ext: 1 Cause: Destination out of order (27), class = Normal Event (1) ]
Received message for call 0x19e38cf0 on 0x19a25b50 TEI/SAPI 0/0, call->pri is 0x19a25b50 TEI/SAPI 0/0
-- Processing IE 8 (cs0, Cause)
-- Found active call: 0x19e38cf0 cref:32780
q931.c:7119 post_handle_q931_message: Call 32780 enters state 12 (Disconnect Indication). Hold state: Idle
-- ACKing all packets from 18 to (but not including) 18
-- T200 requested to stop when not started
T203 requested to start without stopping first
-- Starting T203 timer
Sending Receiver Ready (34)
TEI: 0 State 7
V(S) 18 V(A) 18 V(R) 34
K 7, RC 0, l3initiated 0, reject_except 0 ack_pend 0
T200 0, N200 3, T203 1

> [ 02 01 01 44 ]

> Supervisory frame:
> SAPI: 00 C/R: 1 EA: 0
> TEI: 000 EA: 1
> Zero: 0 S: 0 01: 1 [ RR (receive ready) ]
> N(R): 034 P/F: 0

[Kpbx*CLI>
[0K> 0 bytes of data
Handling message for SAPI/TEI=0/0
-- Span 1: Channel 0/31 got hangup request, cause 27

[Kpbx*CLI>
[0K -- DAHDI/31-1 is circuit-busy
q931_hangup: other hangup
NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Disconnect Indication, peerstate Disconnect Request, hold-state Idle
q931.c:4639 q931_release: Call 32780 enters state 19 (Release Request). Hold state: Idle
-- Finally transmitting 0, since window opened up (7)
TEI: 0 State 7
V(S) 18 V(A) 18 V(R) 34
K 7, RC 0, l3initiated 0, reject_except 0 ack_pend 0
T200 0, N200 3, T203 1

> [ 00 01 24 44 08 02 00 0c 4d 08 02 81 9b ]

> Informational frame:
> SAPI: 00 C/R: 0 EA: 0
> TEI: 000 EA: 1
> N(S): 018 0: 0
> N(R): 034 P: 0
> 9 bytes of data
-- Stopping T203 timer
-- Starting T200 timer
> Protocol Discriminator: Q.931 ( Cool

len=9
> TEI=0 Call Ref: len= 2 (reference 12/0xC) (Sent from originator)
> Message Type: RELEASE (77)
> [08 02 81 9b]
> Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
> Ext: 1 Cause: Destination out of order (27), class = Normal Event (1) ]
-- Hungup 'DAHDI/31-1'
== Everyone is busy/congested at this time (1:0/1/0)

[Kpbx*CLI>
[0K -- Executing [s@macro-dialout-trunk:21] [1;36mNoOp[0m("[1;35mSIP/626-0000006d[0m", "[1;35mDial failed for some reason with DIALSTATUS = CONGESTION and HANGUPCAUSE = 27[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-dialout-trunk:22] [1;36mGoto[0m("[1;35mSIP/626-0000006d[0m", "[1;35ms-CONGESTION,1[0m") in new stack
-- Goto (macro-dialout-trunk,s-CONGESTION,1)

[Kpbx*CLI>
[0K -- Executing [s-CONGESTION@macro-dialout-trunk:1] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mRC=27[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s-CONGESTION@macro-dialout-trunk:2] [1;36mGoto[0m("[1;35mSIP/626-0000006d[0m", "[1;35m27,1[0m") in new stack
-- Goto (macro-dialout-trunk,27,1)
-- Executing [27@macro-dialout-trunk:1] [1;36mGoto[0m("[1;35mSIP/626-0000006d[0m", "[1;35mcontinue,1[0m") in new stack
-- Goto (macro-dialout-trunk,continue,1)

[Kpbx*CLI>
[0K -- Executing [continue@macro-dialout-trunk:1] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m1?noreport[0m") in new stack
-- Goto (macro-dialout-trunk,continue,3)
-- Executing [continue@macro-dialout-trunk:3] [1;36mNoOp[0m("[1;35mSIP/626-0000006d[0m", "[1;35mTRUNK Dial failed due to CONGESTION HANGUPCAUSE: 27 - failing through to other trunks[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [continue@macro-dialout-trunk:4] [1;36mSet[0m("[1;35mSIP/626-0000006d[0m", "[1;35mCALLERID(number)=626[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [55564318@from-internal:6] [1;36mMacro[0m("[1;35mSIP/626-0000006d[0m", "[1;35moutisbusy,[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-outisbusy:1] [1;36mProgress[0m("[1;35mSIP/626-0000006d[0m", "[1;35m[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-outisbusy:2] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?emergency,1[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-outisbusy:3] [1;36mGotoIf[0m("[1;35mSIP/626-0000006d[0m", "[1;35m0?intracompany,1[0m") in new stack

[Kpbx*CLI>
[0K -- Executing [s@macro-outisbusy:4] [1;36mPlayback[0m("[1;35mSIP/626-0000006d[0m", "[1;35mall-circuits-busy-now&pls-try-call-later, noanswer[0m") in new stack

[Kpbx*CLI>
[0K -- Playing 'all-circuits-busy-now.alaw' (language 'ru')

[Kpbx*CLI>
[0KTEI: 0 State 7

[Kpbx*CLI>
[0KV(S) 19 V(A) 18 V(R) 34
K 7, RC 0, l3initiated 0, reject_except 0 ack_pend 0
T200 1, N200 3, T203 0

< [ 00 01 01 26 ]

[Kpbx*CLI>
[0K< Supervisory frame:
< SAPI: 00 C/R: 0 EA: 0
< TEI: 000 EA: 1
< Zero: 0 S: 0 01: 1 [ RR (receive ready) ]
< N(R): 019 P/F: 0
< 0 bytes of data

[Kpbx*CLI>
[0K-- ACKing all packets from 18 to (but not including) 19
-- ACKing packet 18, new txqueue is -1 (-1 means empty)

[Kpbx*CLI>
[0K-- Stopping T200 timer

[Kpbx*CLI>
[0K-- Starting T203 timer
Handling message for SAPI/TEI=0/0

[Kpbx*CLI>
[0KTEI: 0 State 7

[Kpbx*CLI>
[0KV(S) 19 V(A) 19 V(R) 34
K 7, RC 0, l3initiated 0, reject_except 0 ack_pend 0

[Kpbx*CLI>
[0KT200 0, N200 3, T203 1

< [ 02 01 44 26 08 02 80 0c 5a 08 02 81 9b ]

< Informational frame:
< SAPI: 00 C/R: 1 EA: 0
< TEI: 000 EA: 1
< N(S): 034 0: 0
< N(R): 019 P: 0

[Kpbx*CLI>
[0K< 9 bytes of data
< Protocol Discriminator: Q.931 ( Cool

len=9
< TEI=0 Call Ref: len= 2 (reference 12/0xC) (Sent to originator)

[Kpbx*CLI>
[0K< Message Type: RELEASE COMPLETE (90)
< [08 02 81 9b]

[Kpbx*CLI>
[0K< Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1)
< Ext: 1 Cause: Destination out of order (27), class = Normal Event (1) ]
Received message for call 0x19e38cf0 on 0x19a25b50 TEI/SAPI 0/0, call->pri is 0x19a25b50 TEI/SAPI 0/0
-- Processing IE 8 (cs0, Cause)
q931.c:7001 post_handle_q931_message: Call 32780 enters state 0 (Null). Hold state: Idle

[Kpbx*CLI>
[0Kq931_hangup: other hangup
NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Null, hold-state Idle
NEW_HANGUP DEBUG: Destroying the call, ourstate Null, peerstate Null, hold-state Idle
-- ACKing all packets from 19 to (but not including) 19
-- T200 requested to stop when not started
T203 requested to start without stopping first

[Kpbx*CLI>
[0K-- Starting T203 timer
Sending Receiver Ready (35)
TEI: 0 State 7
V(S) 19 V(A) 19 V(R) 35
K 7, RC 0, l3initiated 0, reject_except 0 ack_pend 0
T200 0, N200 3, T203 1

[Kpbx*CLI>
[0K
> [ 02 01 01 46 ]

> Supervisory frame:
> SAPI: 00 C/R: 1 EA: 0
> TEI: 000 EA: 1

[Kpbx*CLI>
[0K> Zero: 0 S: 0 01: 1 [ RR (receive ready) ]
> N(R): 035 P/F: 0
> 0 bytes of data
Handling message for SAPI/TEI=0/0

[Kpbx*CLI>
[0K -- Playing 'pls-try-call-later.alaw' (language 'ru')

[Kpbx*CLI>
[0K -- Executing [s@macro-outisbusy:5] [1;36mCongestion[0m("[1;35mSIP/626-0000006d[0m", "[1;35m20[0m") in new stack
== Spawn extension (macro-outisbusy, s, 5) exited non-zero on 'SIP/626-0000006d' in macro 'outisbusy'
== Spawn extension (from-internal, 55564318, 6) exited non-zero on 'SIP/626-0000006d'

[Kpbx*CLI>
[0K -- Executing [h@from-internal:1] [1;36mHangup[0m("[1;35mSIP/626-0000006d[0m", "[1;35m[0m") in new stack
== Spawn extension (from-internal, h, 1) exited non-zero on 'SIP/626-0000006d'

[Kpbx*CLI>

Если короче, то насколько я понял проблема заключается в том, что Ext: 1 Cause: Destination out of order (27)

Вопросы:
Это у меня настройки кривые или проблемы на стороне прова?
Как траблшутить подобные прблемы?

P.S.
Также пробовал поставить switchtype=euroidsn - ничего не изменилось и ошибка та же самая.
Также пробовал строку span=1,0,0,CCS,HDB3 - в этом случае падает D канал.

Провайдер вроде пытается решить проблему, но когда я его прошу прислать мне трейс-логи моего звонка, то в ответ мычит нечто невнятное и логи не присылает.

08.05.2009

#2 30.08.2011 14:46

Попробуйте погонять варианты вызова на номера:
4951111111
84951111111
74951111111

может ваш пров ждет именно такие конструкции, а вы в него семизначку
_________________
P4 3.0 + 1Gb CentOS 5.5 Aster 1.8.5
Не люблю gui-сборки: натуральный продукт вкуснее.

30 Aug 2011

#3 30.08.2011 14:57

Пробовал - не работает
Логи - точно такие же.

12.01.2007

#4 30.08.2011 21:02

судя по ошибке что то не то у провайдера или он не правильно вам дал формат номера и вы шлете не точ что он ждет, или оператора криво настроил свою атс все дело в формате номера
пинайте прова, мычит идите к руководству Smile

всегда работает Smile

ну почти всегда
_________________
нанотехнолигии в области Asterisk

30 Aug 2011

#5 31.08.2011 07:52

Получил трейс-лог от прова.
Кто-нибудь может помочь расшифровать?

===========================================================================
Start to Save Trace Data at 05:31:40PM, August 30, 2011
===========================================================================
maint> 036298 COL 060:02 30 St:co idle (00) EVT Very Happy

5 27 05 04 03 80 90 A3 18 03 A1 83 9F 1E 02 80 83 6C 0C 21 80 34 39 35 32 38 30 37 33 37 33 70 08 80
35 35 36 34 33 31 38 (U0)
036298 C>02 30, D6 06 0D 18 03 A9 83 9E
036298 COL 060:02 30 St:co idle (00) Ev-I:ring start P1: 0 P2: 0 EVT: 11 02 30, C0 00 49
036298 COL 060:02 30 St:di-dialing(00) Ev-I:disa dgt P1: 5 P2: 0 EVT: 80

17 Feb 2009

#6 31.08.2011 08:20

план набора пробовали с unknown на чтонить другое менять ?
локальный и удаленный

12.01.2007

#7 31.08.2011 08:29

вообще по коду это вот

Cause No. 27 - destination out of order.
This cause indicates that the destination indicated by the user cannot be reached because the interface to the destination is not functioning correctly. The term "not functioning correctly" indicates that a signal message was unable to be delivered to the remote party; e.g., a physical layer or data link layer failure at the remote party or user equipment off-line.

коротко что то не то с удаленной стороной т.е. или номер набран неверно или одно из двух Smile

_________________
нанотехнолигии в области Asterisk

30 Aug 2011

#8 31.08.2011 08:46

Планы набора пробовал все последовательно.
Ничего не меняется.

Дело в том, что причина 27 - довольно всеобъемлющая. Там, типа, от физических повреждений линии, запрета на исходящие провом, до прерывания провом звонка на основании чего-либо.

Насколько я понял, звонок доходит до оборудования прова, но там отбивается.
К сожалению, пров не может объяснить по каким причинам он отбивает вызов и не может сам прочитать свой трейс-лог.
Я такой лог тоже читать не умею. Может у кого-нибудь есть опыт и мне смогут помочь?

P.S. На всякий случай открыл саппорт кейс в Диджиуме.

15.09.2008

#9 31.08.2011 10:34

А номер абонента Б вы какой отдаете? Может быть именно это и не нравится оператору связи?

Added after 6 minutes:

А вообще интересно, получается, что вы (по вашему же логу) отдаете оператору номер 556-43-18, а он от вас ждет 495-556-43-18.
Хотя, странно, перечитал еще раз требования оператора к формату набора, ничего там не сказано про номер Б.
_________________
Внимание! Свет в конце тоннеля может быть светом фар приближающегося поезда!
Ubuntu 10.04/10.10 - Asterisk 1.6.2.20

30 Aug 2011

#10 31.08.2011 15:17

Проблема решена.
После 3 дней прочтения своих логов пров поведал мне, что я должен посылать в транк номер в международном формате (12 цифр).
Я в своих экспериментах доходил до 11 цифр, но посылать в транк 0 не догадался.

15.09.2008

#11 31.08.2011 16:34

Вот и дайте оператору по голове Smile

И заодно его название сообщите, мало ли кому еще он такую подлянку подкинет Smile

_________________
Внимание! Свет в конце тоннеля может быть светом фар приближающегося поезда!
Ubuntu 10.04/10.10 - Asterisk 1.6.2.20

14 Sep 2010

#12 31.08.2011 17:20

И заодно его название сообщите, мало ли кому еще он такую подлянку подкинет

Имя оператора в студию !
_________________
Продам виртуальную АТС. Желающим 5% скидка...

15.09.2008

#13 31.08.2011 21:47

Собственно, можно просто посмотреть, за кем 495-280-73-73 закреплен.
_________________
Внимание! Свет в конце тоннеля может быть светом фар приближающегося поезда!
Ubuntu 10.04/10.10 - Asterisk 1.6.2.20

15.09.2008

#14 01.09.2011 05:36

По данным Россвязи это Мастертел.
_________________
Внимание! Свет в конце тоннеля может быть светом фар приближающегося поезда!
Ubuntu 10.04/10.10 - Asterisk 1.6.2.20

30 Aug 2011

#15 01.09.2011 07:36

Странно, ибо наш пров - Бизтелеком

15.09.2008

#16 01.09.2011 08:28

Может емкость перепродали и в данных Россвязи не обновили.
_________________
Внимание! Свет в конце тоннеля может быть светом фар приближающегося поезда!
Ubuntu 10.04/10.10 - Asterisk 1.6.2.20

07.01.2009

#17 01.09.2011 09:54

"Получил трейс-лог от прова.
Кто-нибудь может помочь расшифровать? "
Smile

ЛыЖа.

30 Aug 2011

#18 01.09.2011 13:19

Не очень понял юмор.

Я не умею расшифровывать трейс-логи подобного формата, поэтому попросил помощи.
Что-то не так?

07.01.2009

#19 01.09.2011 13:56

ЛыЖа=LG - производитель станции вашего оператора.