On my EuroISDN PRI link, a pri debug on the same type of call yields the messages below. What could I try to do to see why the QSIG pri link doesn't work (times out)?
Thanks < Call Ref: len= 2 (reference 1065/0x429) (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 a9 83 93] < Channel ID (len= 5) [ Ext: 1 IntID: Implicit PRI Spare: 0 Exclusive Dchan: 0 < ChanSel: As indicated in following octets < Ext: 1 Coding: 0 Number Specified Channel Type: 3 < Ext: 1 Channel: 19 ] < [6c 06 00 81 33 32 31 30] < Calling Number (len= 8) [ Ext: 0 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) < Presentation: Presentation permitted, user number passed network screening (1) '3210' ] < [70 08 80 31 30 30 34 30 35 33] < Called Number (len=10) [ Ext: 1 TON: Unknown Number Type (0) NPI: Unknown Number Plan (0) '1004053' ] < [7d 02 91 81] < IE: High-layer Compatibility (len = 4) < [a1] < Sending Complete (len= 1) -- Making new call for cr 1065 -- Processing Q.931 Call Setup -- Processing IE 4 (cs0, Bearer Capability) -- Processing IE 24 (cs0, Channel Identification) -- Processing IE 108 (cs0, Calling Party Number) -- Processing IE 112 (cs0, Called Party Number) -- Processing IE 125 (cs0, High-layer Compatibility) -- Processing IE 161 (cs0, Sending Complete) q931.c:3545 q931_receive: call 1065 on channel 19 enters state 6 (Call Present) q931.c:2810 q931_call_proceeding: call 1065 on channel 19 enters state 9 (Incoming Call Proceeding) > Protocol Discriminator: Q.931 (8) len=11 > Call Ref: len= 2 (reference 1065/0x429) (Terminator) > Message type: CALL PROCEEDING (2) > [18 04 e9 81 83 93] > Channel ID (len= 6) [ Ext: 1 IntID: Explicit PRI Spare: 0 Exclusive > Dchan: 0 > ChanSel: As indicated in following octets > Ext: 1 DS1 Identifier: 1 > Ext: 1 Coding: 0 Number Specified Channel Type: 3 > Ext: 1 Channel: 19 ] q931.c:2945 q931_connect: call 1065 on channel 19 enters state 8 (Connect Request) > Protocol Discriminator: Q.931 (8) len=15 > Call Ref: len= 2 (reference 1065/0x429) (Terminator) > Message type: CONNECT (7) > [18 04 e9 81 83 93] > Channel ID (len= 6) [ Ext: 1 IntID: Explicit PRI Spare: 0 Exclusive > Dchan: 0 > ChanSel: As indicated in following octets > Ext: 1 DS1 Identifier: 1 > Ext: 1 Coding: 0 Number Specified Channel Type: 3 > Ext: 1 Channel: 19 ] > [1e 02 81 82] > Progress Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 > Location: Private network serving the local user (1) > Ext: 1 Progress Description: Called equipment > is non-ISDN. (2) ] < Protocol Discriminator: Q.931 (8) len=10 < Call Ref: len= 2 (reference 1065/0x429) (Originator) < Message type: CONNECT ACKNOWLEDGE (15) < [18 03 a9 83 93] < Channel ID (len= 5) [ Ext: 1 IntID: Implicit PRI Spare: 0 Exclusive Dchan: 0 < ChanSel: As indicated in following octets < Ext: 1 Coding: 0 Number Specified Channel Type: 3 < Ext: 1 Channel: 19 ] -- Processing IE 24 (cs0, Channel Identification) q931.c:3705 q931_receive: call 1065 on channel 19 enters state 10 (Active) < Protocol Discriminator: Q.931 (8) len=9 < Call Ref: len= 2 (reference 1065/0x429) (Originator) < Message type: DISCONNECT (69) < [08 02 81 90] < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1) < Ext: 1 Cause: Normal Clearing (16), class = Normal Event (1) ] -- Processing IE 8 (cs0, Cause) q931.c:3820 q931_receive: call 1065 on channel 19 enters state 12 (Disconnect Indication) NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Disconnect Indication, peerstate Disconnect Request q931.c:2961 q931_release: call 1065 on channel 19 enters state 19 (Release Request) > Protocol Discriminator: Q.931 (8) len=9 > Call Ref: len= 2 (reference 1065/0x429) (Terminator) > Message type: RELEASE (77) > [08 02 81 90] > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 > Location: Private network serving the local user (1) > Ext: 1 Cause: Normal Clearing (16), class = Normal Event > (1) ] < Protocol Discriminator: Q.931 (8) len=9 < Call Ref: len= 2 (reference 1065/0x429) (Originator) < Message type: RELEASE COMPLETE (90) < [08 02 81 90] < Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) Spare: 0 Location: Private network serving the local user (1) < Ext: 1 Cause: Normal Clearing (16), class = Normal Event (1) ] -- Processing IE 8 (cs0, Cause) q931.c:3760 q931_receive: call 1065 on channel 19 enters state 0 (Null) NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Null, peerstate Null NEW_HANGUP DEBUG: Destroying the call, ourstate Null, peerstate Null --- On Thu, 3/19/09, Vieri <rentor...@yahoo.com> wrote: > I have a PRI E1 link between Asterisk 1.4.24 and > Alcatel-Lucent OmniPCX Enterprise R9.0. > > As EuroISDN it works fine. > > However, I need to move to QSIG because of a firmware > upgrade on the Alcatel PBX which doesn't support EuroISDN > (please don't ask why). > > Besides, I've read somewhere that 2 B Channel Transfers > "should" work with * 1.4, the latest 1.4 libpri and QSIG. > So this morning I thought I'd try migrating from EuroISDN > to QSIG. I kept the exact same settings on both Asterisk and > Alcatel since they worked fine over EuroISDN; all I changed > was "switchtype=qsig" on * and used a QSIG trunk group on > Alcatel. > > I tried calling from an Alcatel to an * extension and found > that the destination phone rings but after about 4 seconds > the call is aborted, whether I pick the phone up or not. > > In the following log, Alcatel extension 3210 tries to call > Asterisk extension 4062. > > Can anyone please help? > > Thanks, > Vieri > > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Protocol > Discriminator: Q.931 (8) len=39 > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Call Ref: > len= 2 (reference 20968/0x51E8) (Originator) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Message > type: SETUP (5) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < [a1] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Sending > Complete (len= 1) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < [04 03 80 > 90 a3] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Bearer > Capability (len= 5) [ Ext: 1 Q.931 Std: 0 Info > transfer capability: Speech (0) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < > > Ext: 1 Trans > mode/rate: 64kbps, circuit-mode (16) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < > > User > information layer 1: A-Law (35) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < [18 03 a9 > 83 87] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Channel ID > (len= 5) [ Ext: 1 IntID: Implicit PRI > Spare: 0 Exclusive Dchan: 0 > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < > > ChanSel: As indicated in following > octets > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < > > Ext: 1 Coding: 0 Number > Specified Channel Type: 3 > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < > > Ext: 1 Channel: 7 ] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < [6c 06 00 > 81 33 32 31 30] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Calling > Number (len= 8) [ Ext: 0 TON: Unknown Number Type > (0) NPI: Unknown Number Plan (0) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < > > Presentation: > Presentation permitted, user number passed network screening > (1) '3210' ] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < [70 05 80 > 34 30 36 32] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Called > Number (len= 7) [ Ext: 1 TON: Unknown Number Type > (0) NPI: Unknown Number Plan (0) '4062' ] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < [7d 02 91 > 81] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < IE: > High-layer Compatibility (len = 4) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < [95] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Locking > Shift (len=01): Requested codeset 5 > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < [32 01 81] > [Mar 19 08:04:21] ERROR[11756] chan_dahdi.c: !! < > Unknown IE 50 (cs5, len = 3) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: -- Making new > call for cr 20968 > [Mar 19 08:04:21] VERBOSE[11756] logger.c: -- Processing > Q.931 Call Setup > [Mar 19 08:04:21] VERBOSE[11756] logger.c: -- Processing IE > 161 (cs0, Sending Complete) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: -- Processing IE > 4 (cs0, Bearer Capability) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: -- Processing IE > 24 (cs0, Channel Identification) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: -- Processing IE > 108 (cs0, Calling Party Number) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: -- Processing IE > 112 (cs0, Called Party Number) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: -- Processing IE > 125 (cs0, High-layer Compatibility) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: -- Processing IE > 50 (cs5, Unknown Information Element) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: !! Unknown IE 50 > (cs5, Unknown Information Element) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: q931.c:3545 > q931_receive: call 20968 on channel 7 enters state 6 (Call > Present) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: q931.c:2810 > q931_call_proceeding: call 20968 on channel 7 enters state 9 > (Incoming Call Proceeding) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: > Protocol > Discriminator: Q.931 (8) len=11 > [Mar 19 08:04:21] VERBOSE[11756] logger.c: > Call Ref: > len= 2 (reference 20968/0x51E8) (Terminator) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: > Message > type: CALL PROCEEDING (2) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: > [18 04 e9 > 81 83 87] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: > Channel ID > (len= 6) [ Ext: 1 IntID: Explicit PRI > Spare: 0 Exclusive Dchan: 0 > [Mar 19 08:04:21] VERBOSE[11756] logger.c: > > > ChanSel: As indicated in following > octets > [Mar 19 08:04:21] VERBOSE[11756] logger.c: > > > Ext: 1 DS1 Identifier: > 1 > [Mar 19 08:04:21] VERBOSE[11756] logger.c: > > > Ext: 1 Coding: 0 Number > Specified Channel Type: 3 > [Mar 19 08:04:21] VERBOSE[11756] logger.c: > > > Ext: 1 Channel: 7 ] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: > -- Accepting call from '3210' to '4062' on > channel 1/7, span 1 > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > -- Executing > [4...@from-pstn-deviate-custom:4] Answer("Zap/7-1", "") in > new stack > [Mar 19 08:04:21] VERBOSE[12808] logger.c: q931.c:2943 > q931_connect: call 20968 on channel 7 enters state 10 > (Active) > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > Protocol > Discriminator: Q.931 (8) len=15 > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > Call Ref: > len= 2 (reference 20968/0x51E8) (Terminator) > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > Message > type: CONNECT (7) > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > [18 04 e9 > 81 83 87] > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > Channel ID > (len= 6) [ Ext: 1 IntID: Explicit PRI > Spare: 0 Exclusive Dchan: 0 > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > > > ChanSel: As indicated in following > octets > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > > > Ext: 1 DS1 Identifier: > 1 > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > > > Ext: 1 Coding: 0 Number > Specified Channel Type: 3 > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > > > Ext: 1 Channel: 7 ] > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > [1e 02 81 > 82] > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > Progress > Indicator (len= 4) [ Ext: 1 Coding: CCITT (ITU) > standard (0) 0: 0 Location: Private network > serving the local user (1) > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > > > Ext: > 1 Progress Description: Called equipment is non-ISDN. > (2) ] > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > -- Goto (custom-TOSIP,4062,1) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Protocol > Discriminator: Q.931 (8) len=13 > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Call Ref: > len= 2 (reference 20968/0x51E8) (Originator) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Message > type: STATUS (125) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < [08 03 80 > e4 18] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Cause (len= > 5) [ Ext: 1 Coding: CCITT (ITU) standard (0) > Spare: 0 Location: User (0) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < > Ext: > 1 Cause: Invalid information element contents (100), > class = Protocol Error (e.g. unknown message) (6) ] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < > Cause data 1: 18 > (24) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < [14 01 01] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Call State > (len= 3) [ Ext: 0 Coding: CCITT (ITU) standard > (0) Call state: Call Initiated (1) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: -- Processing IE > 8 (cs0, Cause) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: -- Processing IE > 20 (cs0, Call State) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Protocol > Discriminator: Q.931 (8) len=13 > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Call Ref: > len= 2 (reference 20968/0x51E8) (Originator) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Message > type: STATUS (125) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < [08 03 80 > e4 18] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Cause (len= > 5) [ Ext: 1 Coding: CCITT (ITU) standard (0) > Spare: 0 Location: User (0) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < > Ext: > 1 Cause: Invalid information element contents (100), > class = Protocol Error (e.g. unknown message) (6) ] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < > Cause data 1: 18 > (24) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < [14 01 01] > [Mar 19 08:04:21] VERBOSE[11756] logger.c: < Call State > (len= 3) [ Ext: 0 Coding: CCITT (ITU) standard > (0) Call state: Call Initiated (1) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: -- Processing IE > 8 (cs0, Cause) > [Mar 19 08:04:21] VERBOSE[11756] logger.c: -- Processing IE > 20 (cs0, Call State) > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > -- Executing [...@macro-dial:7] > Dial("Zap/7-1", "SIP/4062||tTwW") in new stack > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > -- Called 4062 > [Mar 19 08:04:21] VERBOSE[12808] logger.c: > -- SIP/4062-b4143ed0 is ringing > [Mar 19 08:04:23] VERBOSE[12808] logger.c: > -- SIP/4062-b4143ed0 answered Zap/7-1 > [Mar 19 08:04:25] VERBOSE[11756] logger.c: < Protocol > Discriminator: Q.931 (8) len=12 > [Mar 19 08:04:25] VERBOSE[11756] logger.c: < Call Ref: > len= 2 (reference 20968/0x51E8) (Originator) > [Mar 19 08:04:25] VERBOSE[11756] logger.c: < Message > type: RELEASE COMPLETE (90) > [Mar 19 08:04:25] VERBOSE[11756] logger.c: < [08 05 80 > e6 33 30 33] > [Mar 19 08:04:25] VERBOSE[11756] logger.c: < Cause (len= > 7) [ Ext: 1 Coding: CCITT (ITU) standard (0) > Spare: 0 Location: User (0) > [Mar 19 08:04:25] VERBOSE[11756] logger.c: < > Ext: > 1 Cause: Recover on timer expiry (102), class = > Protocol Error (e.g. unknown message) (6) ] > [Mar 19 08:04:25] VERBOSE[11756] logger.c: < > Cause data:[Mar 19 > 08:04:25] VERBOSE[11756] logger.c: 33[Mar 19 08:04:25] > VERBOSE[11756] logger.c: 30[Mar 19 08:04:25] > VERBOSE[11756] logger.c: 33[Mar 19 08:04:25] > VERBOSE[11756] logger.c: (Timer T[Mar 19 08:04:25] > VERBOSE[11756] logger.c: 3[Mar 19 08:04:25] VERBOSE[11756] > logger.c: 0[Mar 19 08:04:25] VERBOSE[11756] logger.c: 3[Mar > 19 08:04:25] VERBOSE[11756] logger.c: ) > [Mar 19 08:04:25] VERBOSE[11756] logger.c: -- Processing IE > 8 (cs0, Cause) > [Mar 19 08:04:25] VERBOSE[11756] logger.c: q931.c:3760 > q931_receive: call 20968 on channel 7 enters state 0 (Null) > [Mar 19 08:04:25] VERBOSE[11756] logger.c: > -- Channel 1/7, span 1 got hangup, cause > 102 > [Mar 19 08:04:25] VERBOSE[12808] logger.c: > -- Executing [...@macro-dial:1] > Macro("Zap/7-1", "hangupcall") in new stack > [Mar 19 08:04:25] VERBOSE[12808] logger.c: > -- Executing [...@macro-hangupcall:11] > Hangup("Zap/7-1", "") in new stack > [Mar 19 08:04:25] DEBUG[12808] chan_dahdi.c: Set option > AUDIO MODE, value: ON(1) on Zap/7-1 > [Mar 19 08:04:25] DEBUG[12808] chan_dahdi.c: Already > hungup... Calling hangup once, and clearing call > [Mar 19 08:04:25] VERBOSE[12808] logger.c: NEW_HANGUP > DEBUG: Calling q931_hangup, ourstate Null, peerstate Null > [Mar 19 08:04:25] VERBOSE[12808] logger.c: NEW_HANGUP > DEBUG: Destroying the call, ourstate Null, peerstate Null > [Mar 19 08:04:25] DEBUG[12808] chan_dahdi.c: Set option > AUDIO MODE, value: OFF(0) on Zap/7-1 > [Mar 19 08:04:25] VERBOSE[12808] logger.c: > -- Hungup 'Zap/7-1' > _______________________________________________ -- Bandwidth and Colocation Provided by http://www.api-digital.com -- asterisk-users mailing list To UNSUBSCRIBE or update options visit: http://lists.digium.com/mailman/listinfo/asterisk-users