I have the following problem with calling foreign cell phones (NL) from Belgium, attached is the debug log.
When the foreign cell phone is called and the user on the remote end presses REJECT on the cell phone, we should get his voicemail. But for some reason * plays our chanunavail message. It doesn’t get to play the voicemail to the users.
This has also happened on calling to other foreign (european) cell phones. The setup is latest asterisk on a Digium TE110P.
Any advice on where to look at? This might be related to the issue of not getting the telco error message when dialing wrong or non-existing numbers. (I always get the chanunavail message that is setup but prefer to the the telco-voice)
Thanks in advance!
cheers!
Sep 6 13:55:48 DEBUG[25780] pbx.c: Launching 'Dial'
Sep 6 13:55:48 VERBOSE[25780] logger.c: -- Executing Dial("SIP/10000015-082217c0", "ZAP/g0/0031xxx|120|r") in new stack
Sep 6 13:55:48 DEBUG[25780] chan_zap.c: Using channel 1
Sep 6 13:55:48 VERBOSE[25780] logger.c: -- Making new call for cr 32806
Sep 6 13:55:48 VERBOSE[25780] logger.c: -- Requested transfer capability: 0x00 - SPEECH
Sep 6 13:55:48 VERBOSE[25780] logger.c: > Protocol Discriminator: Q.931 (8) len=39
Sep 6 13:55:48 VERBOSE[25780] logger.c: > Call Ref: len= 2 (reference 38/0x26) (Originator)
Sep 6 13:55:48 VERBOSE[25780] logger.c: > Message type: SETUP (5)
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [04
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [04 03
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [04 03 80
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [04 03 80 90
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [04 03 80 90 a3
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [04 03 80 90 a3]
Sep 6 13:55:48 VERBOSE[25780] logger.c: > Bearer Capability (len= 5) [ Ext: 1 Q.931 Std: 0 Info transfer capability: Speech (0)
Sep 6 13:55:48 VERBOSE[25780] logger.c: > Ext: 1 Trans mode/rate: 64kbps, circuit-mode (16)
Sep 6 13:55:48 VERBOSE[25780] logger.c: > Ext: 1 User information layer 1: A-Law (35)
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [18
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [18 03
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [18 03 a9
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [18 03 a9 83
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [18 03 a9 83 81
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [18 03 a9 83 81]
Sep 6 13:55:48 VERBOSE[25780] logger.c: > Channel ID (len= 5) [ Ext: 1 IntID: Implicit, PRI Spare: 0, Exclusive Dchan: 0
Sep 6 13:55:48 VERBOSE[25780] logger.c: > ChanSel: Reserved
Sep 6 13:55:48 VERBOSE[25780] logger.c: > Ext: 1 Coding: 0 Number Specified Channel Type: 3
Sep 6 13:55:48 VERBOSE[25780] logger.c: > Ext: 1 Channel: 1 ]
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [6c
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [6c 06
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [6c 06 41
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [6c 06 41 81
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [6c 06 41 81 32
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [6c 06 41 81 32 37
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [6c 06 41 81 32 37 32
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [6c 06 41 81 32 37 32 37
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [6c 06 41 81 32 37 32 37]
Sep 6 13:55:48 VERBOSE[25780] logger.c: > Calling Number (len= 8) [ Ext: 0 TON: Subscriber Number (4) NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1)
Sep 6 13:55:48 VERBOSE[25780] logger.c: > Presentation: Presentation permitted, user number passed network screening (1) '2727' ]
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e c1
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e c1 30
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e c1 30 30
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e c1 30 30 33
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e c1 30 30 33 31
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e c1 30 30 33 31 36
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e c1 30 30 33 31 36 32
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e c1 30 30 33 31 36 32 30
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e c1 30 30 33 31 36 32 30 36
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e c1 30 30 33 31 36 32 30 36 33
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e c1 30 30 33 31 36 32 30 36 33 34
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e c1 30 30 33 31 36 32 30 36 33 34 33
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e c1 30 30 33 31 36 32 30 36 33 34 33 31
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e c1 30 30 33 31 36 32 30 36 33 34 33 31 35
Sep 6 13:55:48 VERBOSE[25780] logger.c: > [70 0e c1 30 30 33 31 36 32 30 36 33 34 33 31 35]
Sep 6 13:55:48 VERBOSE[25780] logger.c: > Called Number (len=16) [ Ext: 1 TON: Subscriber Number (4) NPI: ISDN/Telephony Numbering Plan (E.164/E.163) (1) '0031xxx' ]
Sep 6 13:55:48 VERBOSE[25780] logger.c: -- Called g0/0031xxx
Sep 6 13:56:03 VERBOSE[25780] logger.c: -- Zap/1-1 is proceeding passing it to SIP/10000015-082217c0
Sep 6 13:56:03 VERBOSE[25780] logger.c: -- Zap/1-1 is ringing
Sep 6 13:56:34 VERBOSE[25780] logger.c: -- Zap/1-1 is making progress passing it to SIP/10000015-082217c0
Sep 6 13:56:35 DEBUG[25780] channel.c: Hanging up channel 'Zap/1-1'
Sep 6 13:56:35 DEBUG[25780] chan_zap.c: zt_hangup(Zap/1-1)
Sep 6 13:56:35 DEBUG[25780] chan_zap.c: Set option AUDIO MODE, value: ON(1) on Zap/1-1
Sep 6 13:56:35 DEBUG[25780] chan_zap.c: Hangup: channel: 1 index = 0, normal = 14, callwait = -1, thirdcall = -1
Sep 6 13:56:35 DEBUG[25780] chan_zap.c: Not yet hungup... Calling hangup once with icause, and clearing call
Sep 6 13:56:35 VERBOSE[25780] logger.c: NEW_HANGUP DEBUG: Calling q931_hangup, ourstate Disconnect Indication, peerstate Disconnect Request
Sep 6 13:56:35 VERBOSE[25780] logger.c: > Protocol Discriminator: Q.931 (8) len=9
Sep 6 13:56:35 VERBOSE[25780] logger.c: > Call Ref: len= 2 (reference 38/0x26) (Originator)
Sep 6 13:56:35 VERBOSE[25780] logger.c: > Message type: RELEASE (77)
Sep 6 13:56:35 VERBOSE[25780] logger.c: > [
Sep 6 13:56:35 VERBOSE[25780] logger.c: > [08
Sep 6 13:56:35 VERBOSE[25780] logger.c: > [08 02
Sep 6 13:56:35 VERBOSE[25780] logger.c: > [08 02 81
Sep 6 13:56:35 VERBOSE[25780] logger.c: > [08 02 81 93
Sep 6 13:56:35 VERBOSE[25780] logger.c: > [08 02 81 93]
Sep 6 13:56:35 VERBOSE[25780] logger.c: > Cause (len= 4) [ Ext: 1 Coding: CCITT (ITU) standard (0) 0: 0 Location: Private network serving the local user (1)
Sep 6 13:56:35 VERBOSE[25780] logger.c: > Ext: 1 Cause: Unknown (19), class = Normal Event (1) ]
Sep 6 13:56:35 DEBUG[25780] chan_zap.c: disabled echo cancellation on channel 1
Sep 6 13:56:35 DEBUG[25780] chan_zap.c: Set option TDD MODE, value: OFF(0) on Zap/1-1
Sep 6 13:56:35 DEBUG[25780] chan_zap.c: Updated conferencing on 1, with 0 conference users
Sep 6 13:56:35 DEBUG[25780] chan_zap.c: Set option AUDIO MODE, value: OFF(0) on Zap/1-1
Sep 6 13:56:35 DEBUG[25780] chan_zap.c: disabled echo cancellation on channel 1
Sep 6 13:56:35 VERBOSE[25780] logger.c: -- Hungup 'Zap/1-1'
Sep 6 13:56:35 VERBOSE[25780] logger.c: == Everyone is busy/congested at this time (1:0/0/1)
Sep 6 13:56:35 DEBUG[25780] app_dial.c: Exiting with DIALSTATUS=CHANUNAVAIL.
Sep 6 13:56:35 DEBUG[25780] pbx.c: Launching 'Goto'
Sep 6 13:56:35 VERBOSE[25780] logger.c: -- Executing Goto("SIP/10000015-082217c0", "s-CHANUNAVAIL|1") in new stack
Sep 6 13:56:35 VERBOSE[25780] logger.c: -- Goto (macro-dialout-trunk,s-CHANUNAVAIL,1)
Sep 6 13:56:35 DEBUG[25780] pbx.c: Launching 'NoOp'
Sep 6 13:56:35 VERBOSE[25780] logger.c: -- Executing NoOp("SIP/10000015-082217c0", "Dial failed due to CHANUNAVAIL") in new stack
Sep 6 13:56:35 DEBUG[25780] pbx.c: Launching 'Macro'
Sep 6 13:56:35 VERBOSE[25780] logger.c: -- Executing Macro("SIP/10000015-082217c0", "outisbusy|") in new stack
Sep 6 13:56:35 DEBUG[25780] pbx.c: Launching 'Playback'
Sep 6 13:56:35 VERBOSE[25780] logger.c: -- Executing Playback("SIP/10000015-082217c0", "all-circuits-busy-now") in new stack