-SOLVED- divacapi und dialout. war:Keine called Party ? divacapi und eingehender Ruf

awaum · 22 Mai 2009

Hallo,

ich habe in meiner Asterisk

CLI> core show version
Asterisk 1.6.0.9 built by root @ asterix.lan on a i686 running Linux on 2009-05-18 19:44:41 UTC

eine Dialogic Diva 4BRI-8 PCI v2 drinstecken,

und betreibe das mit

*CLI> dialogicdiva info
Common ISDN API Driver (1.1.2) www.Dialogic.com
Contr1: 2 B channels total, 2 B channels free.
Contr2: 2 B channels total, 2 B channels free.
Contr3: 2 B channels total, 2 B channels free.
Contr4: 2 B channels total, 2 B channels free.

Am Port 4 (im NT mode) habe ich ein Siemens GIGASET SX455 isdn
über ein S0 Bri Cross-Kabel angeschlossen.

Ein Testruf von einem SIP-Client wird an diesem GIGASET signalisiert.
Jedoch funktioniert das ganze andersherum nicht, ich kann keine Verbindung von diesem GIGASET initieren.

Auf der Asterisk sehe ich ein:

WARNING[8470]: pbx.c:3783 __ast_pbx_run: Channel 'DIALOGICDIVA/DIVA4#02/-1' sent into invalid extension 's' in context 'default', but no invalid handler

# /usr/lib/opendiva/divas/divactrl mlog -c 4 -o

zeigt:

[C:4] 51:3087:702 - D-R(003) 00 C3 7F
[C:4] 51:3087:702 - D-X(003) 00 C3 73
[C:4] 51:3087:724 - D-R(024) 00 C3 00 00 08 01 01 05 04 03 80 90 A3 6C 05 01 80 36 36 36 7D 02 91 81
[C:4] 51:3087:724 - D-X(004) 00 C3 01 02
[C:4] 51:3087:725 - SIG-R(020) 08 01 01 05 04 03 80 90 A3 6C 05 01 80 36 36 36 7D 02 91 81
Q.931 CR01 SETUP
Bearer Capability 80 90 a3
Calling Party Number 01 80 '666'
HLC 91 81
[C:4] 51:3087:726 - SIG-S 0->6 e:805
[C:4] 51:3087:728 - CREATEID ok: context:1f assigned Id:33 freeIds=e8
[C:4] 51:3087:728 - TransactId:0x4d
[C:4] 51:3087:731 - SIG-X(008) 08 01 81 5A 08 02 80 90
Q.931 CR81 REL_COM
Cause 80 90 'Normal call clearing'
[C:4] 51:3087:732 - SIG-S 6->0 e:8da
[C:4] 51:3087:733 - DELETEID ok: deleted Id:32 freeIds=e9
[C:4] 51:3087:733 - D-X(012) 02 C3 00 02 08 01 81 5A 08 02 80 90
[C:4] 51:3087:747 - D-R(004) 02 C3 01 02
[C:4] 51:3097:678 - D-R(004) 00 C3 01 03
[C:4] 51:3097:678 - D-X(004) 00 C3 01 03
[C:4] 51:3107:605 - D-R(003) 00 C3 53
[C:4] 51:3107:606 - D-X(003) 00 C3 73

Reichlich merkwürdig finde ich, daß ich die von mir gewählte Nummer (5722) nirgends im Trace sehe.

Kann mir jemand sagen, was ich überprüfen sollte ?

Vielen Dank für Eure Hilfe!

Viele Grüße,
Armin

armincm · 23 Mai 2009

Die Meldung
"WARNING[8470]: pbx.c:3783 __ast_pbx_run: Channel 'DIALOGICDIVA/DIVA4#02/-1' sent into invalid extension 's' in context 'default', but no invalid handler"
sagt doch ganz klar was passiert. Wenn du mit dem Gigaset telefonierst, wird offensichtlich keine direkte Blockwahl gemacht (also keine Zielnummer übertragen), es wird erstmal die Leitung belegt und der Wählton geholt. Erst dann folgen wohl die Ziffern. Dieses "Hörer abnehmen und auf Wählton warten" landet in Asterisk in deinem Context ohne Zielnummer, also in der 's' extension. Diese musst du dann auch konfigurieren. Hier kannst du dann einen Wählton einspielen
(oder was auch immer) und dann mit z.B. Waitexten() auf (weitere) Ziffern warten.

Armin

awaum · 25 Mai 2009

armincm schrieb:
Wenn du mit dem Gigaset telefonierst, wird offensichtlich keine direkte Blockwahl gemacht (also keine Zielnummer übertragen), es wird erstmal die Leitung belegt und der Wählton geholt. Erst dann folgen wohl die Ziffern.

Ich wusste gar nicht, daß es sowas beim ISDN überhaupt gibt... Ich dachte der Wählton, den man bekommt, wenn man an einem ISDN-Telefon den Hörer abnimmt, kommt vom Telefon selbst.....

Kann ich solche Anfängerfragen irgendwo nachlesen ?

armincm schrieb:
Dieses "Hörer abnehmen und auf Wählton warten" landet in Asterisk in deinem Context ohne Zielnummer, also in der 's' extension. Diese musst du dann auch konfigurieren. Hier kannst du dann einen Wählton einspielen
(oder was auch immer) und dann mit z.B. Waitexten() auf (weitere) Ziffern warten.

Ich habe jetzt in dem context des GIGASETS ein

Code:

exten => s,1,Answer()
exten => s,n,WaitExten(5)

eingetragen.

Das geht schon... aber das ist trotzdem anders, als wenn ich das GIGASET direkt am NTBA betreibe.

Wenn ich dort die Wahlwiederholung drücke, höre ich erst nichts, und nach etwa 3 Sekunden einen Rufton.

Mache ich das gleiche an der Asterisk, mit der s-extension von oben, dann höre ich erst mal das Gigaset die Töne runterspielen, und dann fast 10 Sekunden nichts mehr, dann schließlich den Rufton. -> dauert fast 5 mal so lange.

Irgendwie verhält sich das Telefon an der Karte anders als am NTBA... was könnte das sein ?

Ich sehe schon im Trace, daß das GIGASET gar keine Called Party bestimmt... und daß die Rufnummer wohl durch Tohnwahl (IMHO im B-Kanal) übertragen wird..... aber geht das nicht anders ?

Vielen Dank für jeden Zuspruch

Grüße,
Armin

armincm · 25 Mai 2009

Ohne verbose log kann ich zu den Punkten nicht viel sagen.
Aber warum machst du im 's' denn jetzt ein Answer() ? Warum willst du den Anruf hier schon annehmen? Wenn du auf weitere Ziffern warten willst, solltest du das nicht. Oder allenfalls, zum Abpsielen von Tönen (Wählton) ein capicommand(progress) vorher, damit du early-B3 sound an das Telefon geben kannst.

Armin

awaum · 26 Mai 2009

Hallo Armin,

vielen Dank für Deine Antwort.

armincm schrieb:
Aber warum machst du im 's' denn jetzt ein Answer() ? Warum willst du den Anruf hier schon annehmen? Wenn du auf weitere Ziffern warten willst, solltest du das nicht.

Weil es sonst gar nicht geht...

Code:

*CLI> dialplan show isdn-phones
[ Context 'isdn-phones' created by 'pbx_config' ]
  '5722' =>         1. Dial(${ARMIN})                             [pbx_config]
  's' =>            1. WaitExten(10)                              [pbx_config]
  '_X.' =>          1. Dial(DIALOGICDIVA/DIVA1/${EXTEN})          [pbx_config]

-= 3 extensions (3 priorities) in 1 context. =-
*CLI> core set verbose 1000
Verbosity is at least 1000
*CLI>   == DIVA4#02: Incoming call '666' -> ''
    -- Executing [s@isdn-phones:1] WaitExten("DIALOGICDIVA/DIVA4#02/-1", "10") in new stack
[May 26 15:46:23] WARNING[12838]: pbx.c:7855 pbx_builtin_waitexten: Timeout but no rule 't' in context 'isdn-phones'
  == Spawn extension (isdn-phones, s, 1) exited non-zero on 'DIALOGICDIVA/DIVA4#02/-1'
  == DIVA4#02: DIALOGICDIVA Hangingup for PLCI=0x504 in state 8
       > DIVA4#02: CAPI INFO 0x3490: Normal call clearing

und das GIGASET sagt "Hat aufgelegt", wobei allerdings noch nicht mal ein Rufton zu hören war.

Habe ich das Answer() drin:

Code:

*CLI> dialplan show isd
isdn-in      isdn-phones
*CLI> dialplan show isdn-phones
[ Context 'isdn-phones' created by 'pbx_config' ]
  '5722' =>         1. Dial(${ARMIN})                             [pbx_config]
  's' =>            1. Answer()                                   [pbx_config]
                    2. WaitExten(10)                              [pbx_config]
  '_X.' =>          1. Dial(DIALOGICDIVA/DIVA1/${EXTEN})          [pbx_config]

-= 3 extensions (4 priorities) in 1 context. =-
*CLI> core set verbose 1000
Verbosity was 0 and is now 1000
*CLI>   == DIVA4#02: Incoming call '666' -> ''
    -- Executing [s@isdn-phones:1] Answer("DIALOGICDIVA/DIVA4#02/-0", "") in new stack
  == DIVA4#02: Answering for
    -- Executing [s@isdn-phones:2] WaitExten("DIALOGICDIVA/DIVA4#02/-0", "10") in new stack
  == CDR updated on DIALOGICDIVA/DIVA4#02/-0
    -- Executing [01728827296@isdn-phones:1] Dial("DIALOGICDIVA/DIVA4#02/-0", "DIALOGICDIVA/DIVA1/017212345678") in new stack
    -- Called DIVA1/017212345678
    -- DIALOGICDIVA/DIVA1#02/017212345678-1 is proceeding passing it to DIALOGICDIVA/DIVA4#02/-0
    -- DIALOGICDIVA/DIVA1#02/017212345678-1 is making progress passing it to DIALOGICDIVA/DIVA4#02/-0
    -- DIALOGICDIVA/DIVA1#02/017212345678-1 is ringing
  == DIVA1#02: DIALOGICDIVA Hangingup for PLCI=0x201 in state 5
       > DIVA4#02: CAPI INFO 0x3490: Normal call clearing
       > DIVA1#02: CAPI INFO 0x3490: Normal call clearing
  == Spawn extension (isdn-phones, 017212345678, 1) exited non-zero on 'DIALOGICDIVA/DIVA4#02/-0'
  == DIVA4#02: DIALOGICDIVA Hangingup for PLCI=0xdead0000 in state 4

... dann kann ich wenigstens telefonieren.

Hast Du eine Idee ?

Viele Grüße,
Armin

armincm · 27 Mai 2009

awaum schrieb:
Weil es sonst gar nicht geht...

Dann hast du was falsch gemacht.
Bei mir sieht das etwa so aus:

Code:

exten => s,1,capicommand(progress)
exten => s,2,Set(TIMEOUT(digit)=4)
exten => s,3,Set(TIMEOUT(response)=4)
exten => s,4,WaitExten(5)
exten => _X.,1,Dial(... ${EXTEN} ....)

Wenn timeout kommt, dann heisst das wohl WaitExten hat keine Ziffern bekommen. Eventuell ist dann ein verbose log hilfreich um zu sehen, was das Telefon überhaupt schickt.

Armin

awaum · 28 Mai 2009

armincm schrieb:
Bei mir sieht das etwa so aus:

Code:

exten => s,1,capicommand(progress)

Das geht wohl nur wenn man die chan_capi verwendet, ich verdende aber doch die chan_dialogicdiva...
Irgendwo auf der Dialogic-Seite habe ich gelesen, daß chan_dialogicdiva jetzt scheinbar doch mehr kann.... und diese Veröffentlichung war neuer als Dein Posting vom April letzten Jahres, in dem Du gesagt hast, daß die praktisch gleich sind...

armincm schrieb:

Auch wenn ich Deine erste Zeile auskommentiere:

Code:

*CLI> dialplan show isdn-phones
[ Context 'isdn-phones' created by 'pbx_config' ]
  's' =>            2. Set(TIMEOUT(digit)=4)                      [pbx_config]
                    3. Set(TIMEOUT(response)=4)                   [pbx_config]
                    4. WaitExten(5)                               [pbx_config]
  '_X.' =>          1. Dial(... ${EXTEN} ....)                    [pbx_config]

-= 2 extensions (4 priorities) in 1 context. =-

dann sieht der Trace so aus:

Code:

[C:4] 17:2373:662 - D-R(024) 00 9F 06 06 08 01 01 05 04 03 80 90 A3 6C 05 01 80 36 36 36 7D 02 91 81
[C:4] 17:2373:662 - D-X(004) 00 9F 01 08
[C:4] 17:2373:663 - SIG-R(020) 08 01 01 05 04 03 80 90 A3 6C 05 01 80 36 36 36 7D 02 91 81
                     Q.931  CR01 SETUP
                            Bearer Capability 80 90 a3
                            Calling Party Number 01 80 '666'
                            HLC 91 81
[C:4] 17:2373:664 - SIG-S 0->6 e:805
[C:4] 17:2373:666 - CREATEID ok: context:1f assigned Id:23 freeIds=e8
[C:4] 17:2373:666 - TransactId:0x29
[C:4] 17:2373:670 - SIG-X(008) 08 01 81 5A 08 02 80 90
                     Q.931  CR81 REL_COM
                            Cause 80 90 'Normal call clearing'
[C:4] 17:2373:671 - SIG-S 6->0 e:8da
[C:4] 17:2373:672 - DELETEID ok: deleted Id:22 freeIds=e9
[C:4] 17:2373:672 - D-X(012) 02 9F 06 08 08 01 81 5A 08 02 80 90
[C:4] 17:2373:688 - D-R(004) 02 9F 01 08
[C:4] 17:2383:620 - D-R(004) 00 9F 01 09
[C:4] 17:2383:620 - D-X(004) 00 9F 01 09
[C:4] 17:2393:547 - D-R(003) 00 9F 53
[C:4] 17:2393:547 - D-X(003) 00 9F 73

und am GIGASET bekomme ich sofort einen Besetztton, und auf der CLI steht wieder:

Code:

[May 28 11:04:11] WARNING[4347]: pbx.c:3783 __ast_pbx_run: Channel 'DIALOGICDIVA/DIVA4#02/-3' sent into invalid extension 's' in context 'default', but no invalid handler

Inzwischen sehe ich aber die called party wenn ich folgenden dialplan verwende:

Code:

exten => s,1,WaitExten(10)
exten => _X.,1, Dial(DIALOGICDIVA/DIVA1/${EXTEN})

Dann sehe ich ich im trace:

Code:

[C:4] 17:2718:874 - D-R(003) 00 9F 7F
[C:4] 17:2718:875 - D-X(003) 00 9F 73
[C:4] 17:2718:896 - D-R(024) 00 9F 00 00 08 01 01 05 04 03 80 90 A3 6C 05 01 80 36 36 36 7D 02 91 81
[C:4] 17:2718:897 - D-X(004) 00 9F 01 02
[C:4] 17:2718:898 - SIG-R(020) 08 01 01 05 04 03 80 90 A3 6C 05 01 80 36 36 36 7D 02 91 81
                     Q.931  CR01 SETUP
                            Bearer Capability 80 90 a3
                            Calling Party Number 01 80 '666'
                            HLC 91 81
[C:4] 17:2718:898 - SIG-S 0->6 e:805
[C:4] 17:2718:901 - CREATEID ok: context:1f assigned Id:24 freeIds=e8
[C:4] 17:2718:901 - TransactId:0x2a
[C:4] 17:2719:381 - SIG-EVENT FF00
[C:4] 17:2719:381 - SIG-x(007) 08 01 81 0D 18 01 89
                     Q.931  CR81 SETUP_ACK
                            Channel Id 89
[C:4] 17:2719:381 - SIG-S 6->25 e:ff00
[C:4] 17:2719:383 - D-X(011) 02 9F 00 02 08 01 81 0D 18 01 89
[C:4] 17:2719:399 - D-R(004) 02 9F 01 02
[C:4] 17:2719:467 - D-R(022) 00 9F 02 02 08 01 01 7B 70 0C 81 30 31 37 32 38 38 32 37 32 39 36
[C:4] 17:2719:467 - D-X(004) 00 9F 01 04
[C:4] 17:2719:468 - SIG-R(018) 08 01 01 7B 70 0C 81 30 31 37 32 38 38 32 37 32 39 36
                     Q.931  CR01 INFO
                            Called Party Number 81 '017212345678'

unknown command <>

unknown command <>

unknown command <>

unknown command <>
[C:4] 17:2728:903 - SIG-X(008) 08 01 81 5A 08 02 80 90
                     Q.931  CR81 REL_COM
                            Cause 80 90 'Normal call clearing'
[C:4] 17:2728:903 - SIG-x(008) 08 01 81 45 08 02 80 90
                     Q.931  CR81 DISC
                            Cause 80 90 'Normal call clearing'
[C:4] 17:2728:904 - SIG-S 25->11 e:8da
[C:4] 17:2728:905 - DELETEID ok: deleted Id:23 freeIds=e9
[C:4] 17:2728:905 - D-X(012) 02 9F 02 04 08 01 81 45 08 02 80 90
[C:4] 17:2728:921 - D-R(004) 02 9F 01 04
[C:4] 17:2732:648 - D-R(012) 00 9F 04 04 08 01 01 4D 08 02 80 90
[C:4] 17:2732:649 - D-X(004) 00 9F 01 06
[C:4] 17:2732:650 - SIG-R(008) 08 01 01 4D 08 02 80 90
                     Q.931  CR01 REL
                            Cause 80 90 'Normal call clearing'
[C:4] 17:2732:650 - SIG-x(004) 08 01 81 5A
                     Q.931  CR81 REL_COM
[C:4] 17:2732:650 - SIG-S 11->0 e:84d
[C:4] 17:2732:652 - D-X(008) 02 9F 04 06 08 01 81 5A
[C:4] 17:2732:666 - D-R(004) 02 9F 01 06

Am GIGASET höre ich zwar nichts... aber scheinbar sendet es jetzt die called party. Es passiert dann einige Zeit nichts, und schließlich zeigt mir das Display des GIGASETS an "Hat aufgelegt" an, Töne sind dabei keine zu hören.

Jetzt kommt's:
Auf der CLI sehe ich:

Code:

[May 28 11:12:30] WARNING[4420]: pbx.c:7855 pbx_builtin_waitexten: Timeout but no rule 't' in context 'isdn-phones'

... und das obwohl zumindest im Trace die called party auftaucht...

armincm schrieb:
Wenn timeout kommt, dann heisst das wohl WaitExten hat keine Ziffern bekommen. Eventuell ist dann ein verbose log hilfreich um zu sehen, was das Telefon überhaupt schickt.

Was meinst Du immer mit dem "verbose log" ? Tut mir leid wenn ich solche Anfängerfragen stelle. Ich bin Dir wirklich sehr dankbar, daß Du mir immer antwortest.... Was brauchst Du, damit Du mir weiterhelfen kannst ?

armincm · 29 Mai 2009

chan_capi und chan_dialogicdiva haben die gleichen features. Statt capicommand() musst du dann nur dialogicdivacommand() nehmen.

Mit dem verbose log ist das Asterisk log gemeint, welches du mit
set verbose 5
capi debug (bzw. 'dialogicdiva debug')
bekommst. Wenn etwas mit chan_capi/chan_dialogicdiva geloggt werden soll, ist das was hier rausfällt immer ein sehr guter Anfang.

Armin

awaum · 29 Mai 2009

Hallo Armin,

vielen Dank für Deine Antwort.

So, jetzt habe ich was zum entkäfern:
(auch als attachment wegen lesbarkeit)

Code:

# asterisk -c
Asterisk 1.6.0.9, Copyright (C) 1999 - 2008 Digium, Inc. and others.
Created by Mark Spencer <[email protected]>
Asterisk comes with ABSOLUTELY NO WARRANTY; type 'core show warranty' for details.
This is free software, with components licensed under the GNU General Public
License version 2 and other licenses; you are welcome to redistribute it under
certain conditions. Type 'core show license' for details.
=========================================================================
[ Booting...
[ Reading Master Configuration ]
[ Initializing Custom Configuration Options ]
[May 29 14:20:19] NOTICE[5530]: loader.c:869 load_modules: 1 modules will be loaded.
.[May 29 14:20:19] NOTICE[5530]: cdr.c:1430 do_reload: CDR simple logging enabled.
[May 29 14:20:19] NOTICE[5530]: loader.c:869 load_modules: 164 modules will be loaded.
....[May 29 14:20:19] NOTICE[5530]: res_smdi.c:1272 load_module: No SMDI interfaces are available to listen on, not starting SMDI listener.
........................................................................................................................[May 29 14:20:20] NOTICE[5530]: config.c:1912 ast_config_engine_register: Registered Config Engine curl
........[May 29 14:20:20] WARNING[5530]: translate.c:654 __ast_register_translator: plc_samples 160 format f
.*CLI> .........[May 29 14:20:20] NOTICE[5530]: pbx_ael.c:122 pbx_load_module: Starting AEL load process.
[May 29 14:20:20] NOTICE[5530]: pbx_ael.c:130 pbx_load_module: File /etc/asterisk/extensions.ael not found; AEL declining load
.........SIP channel loading...
[May 29 14:20:20] NOTICE[5530]: chan_sip.c:20938 build_peer: The 'username' field for sip peers has been deprecated in favor of the term 'defaultuser'
.[May 29 14:20:20] ERROR[5530]: chan_capi.c:7383 load_module: Unable to load config capi.conf, chan_capi disabled
......... ]
Asterisk Ready.
[May 29 14:20:20] NOTICE[5560]: chan_dialogicdiva.c:5172 capidev_loop: Started CAPI device thread for CAPI Appl-ID 2.

*CLI> dialplan show isdn-phones
[ Context 'isdn-phones' created by 'pbx_config' ]
  's' =>            1. dialogicdivacommand(progress)              [pbx_config]
                    2. Set(TIMEOUT(digit)=4)                      [pbx_config]
                    3. Set(TIMEOUT(response)=4)                   [pbx_config]
                    4. WaitExten(5)                               [pbx_config]
  '_X.' =>          1. Dial(DIALOGICDIVA/DIVA1/${EXTEN})          [pbx_config]

-= 2 extensions (5 priorities) in 1 context. =-
*CLI> core set verbose 5
Verbosity was 0 and is now 5
*CLI> dialogicdiva debug
DIALOGICDIVA Message Debugging Enabled
*CLI> CAPI: ApplId=0x0002 Command=0x02 SubCommand=0x82 MsgNum=0x0000 NCCI=0x00000204
CONNECT_IND                ID=002 #0x0000 LEN=0037
  Controller/PLCI/NCCI            = 0x204
  CIPValue                        = 0x10
  CalledPartyNumber               = default
  CallingPartyNumber              = <01 80>666
  CalledPartySubaddress           = default
  CallingPartySubaddress          = default
  BC                              = <80 90 a3>
  LLC                             = default
  HLC                             = <91 81>
  AdditionalInfo
   BChannelinformation            = default
   Keypadfacility                 = default
   Useruserdata                   = default
   Facilitydataarray              = default
   SendingComplete                = default

    -- CONNECT_IND (PLCI=0x204,DID=,CID=666,CIP=0x10,CONTROLLER=0x4)
  == DIVA4#02: setting format alaw - 0x8 (alaw)
  == DIVA4#02: Incoming call '666' -> ''
CAPI: ApplId=0x0002 Command=0x08 SubCommand=0x82 MsgNum=0x0001 NCCI=0x00000204
INFO_IND                   ID=002 #0x0001 LEN=0021
  Controller/PLCI/NCCI            = 0x204
  InfoNumber                      = 0x28
  InfoElement                     = LINK<3d>1

INFO_RESP                  ID=002 #0x0001 LEN=0012
  Controller/PLCI/NCCI            = 0x204

    -- DIVA4#02: info element DSP
CAPI: ApplId=0x0002 Command=0x08 SubCommand=0x82 MsgNum=0x0002 NCCI=0x00000204
INFO_IND                   ID=002 #0x0002 LEN=0016
  Controller/PLCI/NCCI            = 0x204
  InfoNumber                      = 0x18
  InfoElement                     = <81>

INFO_RESP                  ID=002 #0x0002 LEN=0012
  Controller/PLCI/NCCI            = 0x204

    -- DIVA4#02: info element CHANNEL IDENTIFICATION 81
CAPI: ApplId=0x0002 Command=0x08 SubCommand=0x82 MsgNum=0x0003 NCCI=0x00000204
INFO_IND                   ID=002 #0x0003 LEN=0015
  Controller/PLCI/NCCI            = 0x204
  InfoNumber                      = 0x8005
  InfoElement                     = default

INFO_RESP                  ID=002 #0x0003 LEN=0012
  Controller/PLCI/NCCI            = 0x204

    -- DIVA4#02: info element SETUP
  == Started pbx on channel DIALOGICDIVA/DIVA4#02/-0
    -- Executing [s@isdn-phones:1] dialogicdivacommand("DIALOGICDIVA/DIVA4#02/-0", "progress") in new stack
    -- dialogicdivacommand: 'progress' '(null)'
SELECT_B_PROTOCOL_REQ      ID=002 #0x0011 LEN=0023
  Controller/PLCI/NCCI            = 0x204
  BProtocol
   B1protocol                     = 0x1
   B2protocol                     = 0x1
   B3protocol                     = 0x0
   B1configuration                = default
   B2configuration                = default
   B3configuration                = default
   GlobalConfiguration            = default

INFO_REQ                   ID=002 #0x0012 LEN=0023
  Controller/PLCI/NCCI            = 0x204
  CalledPartyNumber               = default
  AdditionalInfo
   BChannelinformation            = default
   Keypadfacility                 = default
   Useruserdata                   = default
   Facilitydataarray              = <1e 02 82 88>
   SendingComplete                = default

    -- Executing [s@isdn-phones:2] Set("DIALOGICDIVA/DIVA4#02/-0", "TIMEOUT(digit)=4") in new stack
    -- Digit timeout set to 4
    -- Executing [s@isdn-phones:3] Set("DIALOGICDIVA/DIVA4#02/-0", "TIMEOUT(response)=4") in new stack
    -- Response timeout set to 4
    -- Executing [s@isdn-phones:4] WaitExten("DIALOGICDIVA/DIVA4#02/-0", "5") in new stack
       > chan_dialogicdiva devicestate requested for DIVA4#02/ is 'Ringing'
CAPI: ApplId=0x0002 Command=0x41 SubCommand=0x81 MsgNum=0x0011 NCCI=0x00000204
SELECT_B_PROTOCOL_CONF     ID=002 #0x0011 LEN=0014
  Controller/PLCI/NCCI            = 0x204
  Info                            = 0x0

CAPI: ApplId=0x0002 Command=0x82 SubCommand=0x82 MsgNum=0x0004 NCCI=0x00150204
CONNECT_B3_IND             ID=002 #0x0004 LEN=0013
  Controller/PLCI/NCCI            = 0x150204
  NCPI                            = default

CONNECT_B3_RESP            ID=002 #0x0004 LEN=0015
  Controller/PLCI/NCCI            = 0x150204
  Reject                          = 0x0
  NCPI                            = default

CAPI: ApplId=0x0002 Command=0x08 SubCommand=0x81 MsgNum=0x0012 NCCI=0x00000204
INFO_CONF                  ID=002 #0x0012 LEN=0014
  Controller/PLCI/NCCI            = 0x204
  Info                            = 0x0

CAPI: ApplId=0x0002 Command=0x83 SubCommand=0x82 MsgNum=0x0005 NCCI=0x00150204
CONNECT_B3_ACTIVE_IND      ID=002 #0x0005 LEN=0013
  Controller/PLCI/NCCI            = 0x150204
  NCPI                            = default

CONNECT_B3_ACTIVE_RESP     ID=002 #0x0005 LEN=0012
  Controller/PLCI/NCCI            = 0x150204

CAPI: ApplId=0x0002 Command=0x08 SubCommand=0x82 MsgNum=0x000d NCCI=0x00000204
INFO_IND                   ID=002 #0x000d LEN=0027
  Controller/PLCI/NCCI            = 0x204
  InfoNumber                      = 0x70
  InfoElement                     = <81>017212345678

INFO_RESP                  ID=002 #0x000d LEN=0012
  Controller/PLCI/NCCI            = 0x204

    -- DIVA4#02: info element CALLED PARTY NUMBER
       > DIVA4#02: INFO_IND DID digits not used in this state.
CAPI: ApplId=0x0002 Command=0x08 SubCommand=0x82 MsgNum=0x000e NCCI=0x00000204
INFO_IND                   ID=002 #0x000e LEN=0015
  Controller/PLCI/NCCI            = 0x204
  InfoNumber                      = 0x807b
  InfoElement                     = default

INFO_RESP                  ID=002 #0x000e LEN=0012
  Controller/PLCI/NCCI            = 0x204

    -- DIVA4#02: info element INFORMATION
[May 29 14:20:58] WARNING[5563]: pbx.c:7855 pbx_builtin_waitexten: Timeout but no rule 't' in context 'isdn-phones'
  == Spawn extension (isdn-phones, s, 4) exited non-zero on 'DIALOGICDIVA/DIVA4#02/-0'
  == DIVA4#02: DIALOGICDIVA Hangingup for PLCI=0x204 in state 8
    -- DIVA4#02: activehangingup (cause=0) for PLCI=0x204
CONNECT_RESP               ID=002 #0x0000 LEN=0019
  Controller/PLCI/NCCI            = 0x204
  Reject                          = 0x2
  BProtocol                       = default
  ConnectedNumber                 = default
  ConnectedSubaddress             = default
  LLC                             = default
  AdditionalInfo                  = default

       > chan_dialogicdiva devicestate requested for DIVA4#02/ is 'Not in use'
       > chan_dialogicdiva devicestate requested for DIVA4#02/ is 'Not in use'

# hier lege ich dann auf ...

CAPI: ApplId=0x0002 Command=0x84 SubCommand=0x82 MsgNum=0x024b NCCI=0x00150204
DISCONNECT_B3_IND          ID=002 #0x024b LEN=0015
  Controller/PLCI/NCCI            = 0x150204
  Reason_B3                       = 0x0
  NCPI                            = default

DISCONNECT_B3_RESP         ID=002 #0x024b LEN=0012
  Controller/PLCI/NCCI            = 0x150204

DISCONNECT_REQ             ID=002 #0x0013 LEN=0013
  Controller/PLCI/NCCI            = 0x204
  AdditionalInfo                  = default

CAPI: ApplId=0x0002 Command=0x08 SubCommand=0x82 MsgNum=0x024c NCCI=0x00000204
INFO_IND                   ID=002 #0x024c LEN=0017
  Controller/PLCI/NCCI            = 0x204
  InfoNumber                      = 0x8
  InfoElement                     = <80 90>

INFO_RESP                  ID=002 #0x024c LEN=0012
  Controller/PLCI/NCCI            = 0x204

    -- DIVA4#02: info element CAUSE 80 90
CAPI: ApplId=0x0002 Command=0x08 SubCommand=0x82 MsgNum=0x024d NCCI=0x00000204
INFO_IND                   ID=002 #0x024d LEN=0015
  Controller/PLCI/NCCI            = 0x204
  InfoNumber                      = 0x804d
  InfoElement                     = default

INFO_RESP                  ID=002 #0x024d LEN=0012
  Controller/PLCI/NCCI            = 0x204

    -- DIVA4#02: info element RELEASE
CAPI: ApplId=0x0002 Command=0x04 SubCommand=0x82 MsgNum=0x024f NCCI=0x00000204
DISCONNECT_IND             ID=002 #0x024f LEN=0014
  Controller/PLCI/NCCI            = 0x204
  Reason                          = 0x3490

DISCONNECT_RESP            ID=002 #0x024f LEN=0012
  Controller/PLCI/NCCI            = 0x204

       > DIVA4#02: CAPI INFO 0x3490: Normal call clearing
  == DIVA4#02: Interface cleanup PLCI=0x204

Auf dem GIGASET ist es so, daß ich nach dem Wählen erst mal nichts höre,
und nach ein paar Sekunden einen Besetztton, und auf dem Display die Anzeige "Hat aufgelegt".

Auf dem Trace sieht es so aus:

Code:

[C:4] 44:3589:345 - D-R(003) 00 9F 7F
[C:4] 44:3589:346 - D-X(003) 00 9F 73
[C:4] 44:3589:368 - D-R(024) 00 9F 00 00 08 01 01 05 04 03 80 90 A3 6C 05 01 80 36 36 36 7D 02 91 81
[C:4] 44:3589:368 - D-X(004) 00 9F 01 02
[C:4] 44:3589:369 - SIG-R(020) 08 01 01 05 04 03 80 90 A3 6C 05 01 80 36 36 36 7D 02 91 81
                     Q.931  CR01 SETUP
                            Bearer Capability 80 90 a3
                            Calling Party Number 01 80 '666'
                            HLC 91 81
[C:4] 44:3589:370 - SIG-S 0->6 e:805
[C:4] 44:3589:372 - CREATEID ok: context:1f assigned Id:5a freeIds=e8
[C:4] 44:3589:372 - TransactId:0x4e
[C:4] 44:3589:376 - [C05,0] dsp_assign 1, 0016, 1, 160
[C:4] 44:3589:376 - [C05,*] CAI[00] 16 00 00 00 a0 00
[C:4] 44:3589:376 - [C05,0] Download 532 requested
[C:4] 44:3589:377 - [C05,1] Switching DSP on 1 1 0 0:0 0:0
[C:4] 44:3589:384 - [d6] N-ASSIGN REQ Id:NL_ID, Ch:00
[C:4] 44:3589:384 - CREATEID ok: context:3f assigned Id:5b freeIds=e7
[C:4] 44:3589:385 - [57,*] B2Assign 11 Sig=01 d_id=186a0
[C:4] 44:3589:385 - [C05,*] Assign L2:3 L3:4 free:4795/4800 l:160 d:3588 fc:3588/3088
[C:4] 44:3589:385 - [C05,*] Layer 2 Transparent
[C:4] 44:3589:386 - [d7] N-RC=ASSIGN_OK Id:5b, Ch:00
[C:4] 44:3589:389 - [d8] N-CONNECT IND Id:5b, Ch:17
[C:4] 44:3589:393 - SIG-X(008) 08 01 81 03 1E 02 82 88
                     Q.931  CR81 PROGRESS
                            Progress Indicator 82 88
[C:4] 44:3589:393 - SIG-x(007) 08 01 81 0D 18 01 89
                     Q.931  CR81 SETUP_ACK
                            Channel Id 89
[C:4] 44:3589:393 - SIG-S 6->25 e:883
[C:4] 44:3589:394 - [d9] N-CONNECT ACK REQ Id:5b, Ch:17
[C:4] 44:3589:394 - [da] N-RC=OK Id:5b, Ch:17
[C:4] 44:3589:394 - D-X(011) 02 9F 00 02 08 01 81 0D 18 01 89
[C:4] 44:3589:400 - [C05,1] Starting task 532 00000001
[C:4] 44:3589:400 - [C05,1] TONE CFG 00 00  00 00 00 00 00 0  00 0  00 00
[C:4] 44:3589:402 - [C05,1] DSP startup
[C:4] 44:3589:409 - D-R(004) 02 9F 01 02
[C:4] 44:3589:409 - D-X(012) 02 9F 02 02 08 01 81 03 1E 02 82 88
[C:4] 44:3589:421 - B1-R(160) FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF cont
[C:4] 44:3589:422 - [db] N-DATA IND Id:5b, Ch:17
[C:4] 44:3589:433 - D-R(004) 02 9F 01 04
[C:4] 44:3589:442 - B1-R(160) FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF FF cont
[C:4] 44:3589:442 - [dc] N-DATA IND Id:5b, Ch:17
[C:4] 44:3589:462 - B1-R(160) AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA cont
[C:4] 44:3589:462 - [dd] N-DATA IND Id:5b, Ch:17
[C:4] 44:3589:482 - B1-R(160) AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA cont
[C:4] 44:3589:482 - [de] N-DATA IND Id:5b, Ch:17
[C:4] 44:3589:501 - B1-R(160) AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA cont
[C:4] 44:3589:502 - [df] N-DATA IND Id:5b, Ch:17
[C:4] 44:3589:521 - B1-R(160) AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA cont
[C:4] 44:3589:522 - [e0] N-DATA IND Id:5b, Ch:17
[C:4] 44:3589:537 - D-R(022) 00 9F 02 04 08 01 01 7B 70 0C 81 30 31 37 32 38 38 32 37 32 39 36
[C:4] 44:3589:538 - D-X(004) 00 9F 01 04
[C:4] 44:3589:539 - SIG-R(018) 08 01 01 7B 70 0C 81 30 31 37 32 38 38 32 37 32 39 36
                     Q.931  CR01 INFO
                            Called Party Number 81 '017212345678'
[C:4] 44:3589:541 - B1-R(160) AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA cont
[C:4] 44:3589:542 - [e1] N-DATA IND Id:5b, Ch:17
[C:4] 44:3589:562 - B1-R(160) AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA cont
[C:4] 44:3589:562 - [e2] N-DATA IND Id:5b, Ch:17
[C:4] 44:3589:582 - B1-R(160) AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA AA cont
[C:4] 44:3589:582 - [e3] N-DATA IND Id:5b, Ch:17                                                                                                              


usw.

In 44:3589:539 wieder die called party number... ist das der D-Kanal ?

Das GIGASET vom Netz her über DIVA1 anrufen geht wunderbar, auch die Sprache klappt. Lediglich das Rausrufen geht nicht ....

Hast Du eine Idee ?

Viele Grüße,
Armin

armincm · 29 Mai 2009

Jetzt sehe ich, was du falsch gemacht hast:
> DIVA4#02: INFO_IND DID digits not used in this state.
Du hast den port in msn mode stehen, aber bei nt-mode muss es did sein.

Armin

awaum · 30 Mai 2009

armincm schrieb:
Jetzt sehe ich, was du falsch gemacht hast:
> DIVA4#02: INFO_IND DID digits not used in this state.
Du hast den port in msn mode stehen, aber bei nt-mode muss es did sein.

Genau das war das Problem

Du hast mein Wochenende gerettet, vielen herzlichen Dank dafür !

Für nachfolgende Generationen:
Man muß nur in der /etc/asterisk/dialogicdiva.conf
am entsprechenden Port

isdnmode=did

setzen. Dann geht es.

Das steht auch eigentlich in den Kommentaren von der Konfig-Datei mit drin:
;when using NT-mode, 'DID' should be set in any case
(Nur habe ich diese, als ich diese Sektion für die 4 Ports vervielfältigt habe, nicht mitkopiert, und deshalb an entscheidender Stelle nicht gesehen... stupid me)

Was mich jetzt ein bischen wundert:

Es ist scheinbar völlig egal, was man bei der Adapterkonfiguration
(/usr/lib/opendiva/divas/Config) unter dem Punkt:

"Please select NT-2 (Direct Dial In, Direct Inward Dialing) mode"

angibt...
Kann mir jemand erklären, warum ist das so ?

armincm · 2 Jun 2009

NT-2 (Direct Dial In, Direct Inward Dialing) mode ist bei NT-mode offensichtlich als Option nicht relevant, da
es grundsätzlich so ist. Aber im TE-mode wird hier z.B. zwischen MSN und DID (PtMP - PtP) unterschieden.

Armin

Languages

Suche

Languages

Suche

-SOLVED- divacapi und dialout. war:Keine called Party ? divacapi und eingehender Ruf

awaum

Neuer User

armincm

Aktives Mitglied

awaum

Neuer User

armincm

Aktives Mitglied

awaum

Neuer User

armincm

Aktives Mitglied

awaum

Neuer User

armincm

Aktives Mitglied

awaum

Neuer User

Anhänge

armincm

Aktives Mitglied

awaum

Neuer User

armincm

Aktives Mitglied

Zurzeit aktive Besucher

Neueste Beiträge

Statistik des Forums