Koozali.org: home of the SME Server
Obsolete Releases => SME VoIP (Asterisk, SAIL etc) => Topic started by: jono on November 09, 2009, 09:45:41 PM
-
I'm having a little bother with inbound calls from a small IAX2 provider. Below is what |I'm seeing at the CLI.
Outbound calling works fine, if that's of any use!
-- Accepting UNAUTHENTICATED call from xx.xxx.xxx.xx:
> requested format = alaw,
> requested prefs = (alaw|gsm|g729|ulaw|g726|lpc10|slin|adpcm|speex|ilbc),
> actual format = alaw,
> host prefs = (),
> priority = caller
-- Executing [s@mainmenu:1] GotoIf("IAX2/IAX-3847", "0?s-ZapGroup2|1") in new stack
-- Executing [s@mainmenu:2] AGI("IAX2/IAX-3847", "selintra|CheckState|") in new stack
-- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
-- AGI Script Executing Application: (Dial) Options: (/s|YES|t)
[Nov 9 20:38:39] WARNING[7585]: channel.c:3025 ast_request: No channel type registered for ''
[Nov 9 20:38:39] WARNING[7585]: app_dial.c:1183 dial_exec_full: Unable to create channel of type '' (cause 66 - Channel not implemented)
[Nov 9 20:38:39] WARNING[7585]: app_dial.c:1291 dial_exec_full: Invalid timeout specified: 'YES'
-- AGI Script Executing Application: (Playback) Options: (silence/1)
-- <IAX2/IAX-3847> Playing 'silence/1' (language 'en')
[Nov 9 20:38:39] NOTICE[7585]: chan_iax2.c:3420 iax2_read: I should never be called!
-- AGI Script Executing Application: (Voicemail) Options: (s|u)
[Nov 9 20:38:40] WARNING[7585]: app_voicemail.c:2862 leave_voicemail: No entry in voicemail config file for 's'
-- AGI Script selintra completed, returning 0
-- Sent into invalid extension 's' in context 'extensions' on IAX2/IAX-3847
-- Executing [i@extensions:1] PlayTones("IAX2/IAX-3847", "congestion") in new stack
-- Executing [i@extensions:2] Hangup("IAX2/IAX-3847", "") in new stack
== Spawn extension (extensions, i, 2) exited non-zero on 'IAX2/IAX-3847'
-- Executing [h@extensions:1] Hangup("IAX2/IAX-3847", "") in new stack
== Spawn extension (extensions, h, 1) exited non-zero on 'IAX2/IAX-3847'
-- Hungup 'IAX2/IAX-3847'
-
Executing [s@mainmenu:1]
It's driving the "s" extension, which means it couldn't find a match for the DiD in sip.conf or extensions.conf. This usually means that the DiD your carrier is sending you is not what you think it is. Usually this is because the carrier is sending the call in against your username or accountname rather than your true DiD.
Try using IAX debug (iax2 set debug) from the asterisk console.
Best
S
-
Cheers.
Not sure I'm any the wiser, though :-(
pbx*CLI> iax2 set debug
IAX2 Debugging Enabled
Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: POKE
Timestamp: 00005ms SCall: 10236 DCall: 00000 [195.10.230.110:4569]
Rx-Frame Retry[Yes] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: PONG
Timestamp: 00000ms SCall: 00001 DCall: 10236 [195.10.230.110:4569]
Tx-Frame Retry[-01] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: ACK
Timestamp: 00053ms SCall: 10236 DCall: 00001 [195.10.230.110:4569]
Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: NEW
Timestamp: 00018ms SCall: 09447 DCall: 00000 [195.10.230.110:4569]
VERSION : 2
CALLED NUMBER : s
CODEC_PREFS : (alaw|gsm|g729|ulaw|g726|lpc10|slin|adpcm|speex|ilbc)
CALLING NUMBER : 0xxxxxxxxxx
CALLING PRESNTN : 0
CALLING TYPEOFN : 0
CALLING TRANSIT : 0
CALLING NAME : 0xxxxxxxxxx
LANGUAGE : en
FORMAT : 8
CAPABILITY : 4078
ADSICPE : 2
DATE TIME : 2009-11-09 21:57:34
-- Accepting UNAUTHENTICATED call from 195.10.230.110:
> requested format = alaw,
> requested prefs = (alaw|gsm|g729|ulaw|g726|lpc10|slin|adpcm|speex|ilbc),
> actual format = alaw,
> host prefs = (),
> priority = caller
Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: ACCEPT
Timestamp: 00019ms SCall: 00365 DCall: 09447 [195.10.230.110:4569]
FORMAT : 8
Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: ACK
Timestamp: 00019ms SCall: 09447 DCall: 00365 [195.10.230.110:4569]
-- Executing [s@mainmenu:1] GotoIf("IAX2/IAX-365", "0?s-ZapGroup2|1") in new stack
-- Executing [s@mainmenu:2] AGI("IAX2/IAX-365", "selintra|CheckState|") in new stack
-- Launched AGI Script /var/lib/asterisk/agi-bin/selintra
-- AGI Script Executing Application: (Dial) Options: (/s|YES|t)
[Nov 9 21:57:36] WARNING[7862]: channel.c:3025 ast_request: No channel type registered for ''
[Nov 9 21:57:36] WARNING[7862]: app_dial.c:1183 dial_exec_full: Unable to create channel of type '' (cause 66 - Channel not implemented)
[Nov 9 21:57:36] WARNING[7862]: app_dial.c:1291 dial_exec_full: Invalid timeout specified: 'YES'
-- AGI Script Executing Application: (Playback) Options: (silence/1)
Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 001 Type: CONTROL Subclass: ANSWER
Timestamp: 00541ms SCall: 00365 DCall: 09447 [195.10.230.110:4569]
-- <IAX2/IAX-365> Playing 'silence/1' (language 'en')
Tx-Frame Retry[000] -- OSeqno: 002 ISeqno: 001 Type: VOICE Subclass: 8
Timestamp: 00560ms SCall: 00365 DCall: 09447 [195.10.230.110:4569]
[Nov 9 21:57:36] NOTICE[7862]: chan_iax2.c:3420 iax2_read: I should never be called!
Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: ACK
Timestamp: 00541ms SCall: 09447 DCall: 00365 [195.10.230.110:4569]
Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: CONTROL Subclass: (20?)
Timestamp: 00589ms SCall: 09447 DCall: 00365 [195.10.230.110:4569]
Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK
Timestamp: 00589ms SCall: 00365 DCall: 09447 [195.10.230.110:4569]
Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 003 Type: IAX Subclass: ACK
Timestamp: 00560ms SCall: 09447 DCall: 00365 [195.10.230.110:4569]
Rx-Frame Retry[ No] -- OSeqno: 002 ISeqno: 003 Type: VOICE Subclass: 8
Timestamp: 00820ms SCall: 09447 DCall: 00365 [195.10.230.110:4569]
Tx-Frame Retry[-01] -- OSeqno: 003 ISeqno: 003 Type: IAX Subclass: ACK
Timestamp: 00820ms SCall: 00365 DCall: 09447 [195.10.230.110:4569]
-- AGI Script Executing Application: (Voicemail) Options: (s|u)
[Nov 9 21:57:37] WARNING[7862]: app_voicemail.c:2862 leave_voicemail: No entry in voicemail config file for 's'
-- AGI Script selintra completed, returning 0
-- Sent into invalid extension 's' in context 'extensions' on IAX2/IAX-365
-- Executing [i@extensions:1] PlayTones("IAX2/IAX-365", "congestion") in new stack
-- Executing [i@extensions:2] Hangup("IAX2/IAX-365", "") in new stack
== Spawn extension (extensions, i, 2) exited non-zero on 'IAX2/IAX-365'
-- Executing [h@extensions:1] Hangup("IAX2/IAX-365", "") in new stack
== Spawn extension (extensions, h, 1) exited non-zero on 'IAX2/IAX-365'
-- Hungup 'IAX2/IAX-365'
Tx-Frame Retry[000] -- OSeqno: 003 ISeqno: 003 Type: IAX Subclass: HANGUP
Timestamp: 01562ms SCall: 00365 DCall: 09447 [195.10.230.110:4569]
CAUSE CODE : 66
Rx-Frame Retry[ No] -- OSeqno: 003 ISeqno: 004 Type: IAX Subclass: ACK
Timestamp: 01562ms SCall: 09447 DCall: 00365 [195.10.230.110:4569]
Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: REGREQ
Timestamp: 00010ms SCall: 01285 DCall: 00000 [195.10.230.110:4569]
USERNAME : 106200
REFRESH : 60
Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: REGAUTH
Timestamp: 00015ms SCall: 04751 DCall: 01285 [195.10.230.110:4569]
AUTHMETHODS : 3
CHALLENGE : 180540742
USERNAME : 106200
Tx-Frame Retry[000] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: REGREQ
Timestamp: 00054ms SCall: 01285 DCall: 04751 [195.10.230.110:4569]
USERNAME : 106200
REFRESH : 60
MD5 RESULT : 07bfb090fdb966b97301ea8ca7bcbf07
Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 002 Type: IAX Subclass: REGACK
Timestamp: 00060ms SCall: 04751 DCall: 01285 [195.10.230.110:4569]
USERNAME : 106200
DATE TIME : 2009-11-09 21:57:46
REFRESH : 60
APPARENT ADDRES : IPV4 95.177.75.148:37401
MESSAGE COUNT : 0
CALLING NUMBER : 106200
CALLING NAME : Jono
Tx-Frame Retry[-01] -- OSeqno: 002 ISeqno: 002 Type: IAX Subclass: ACK
Timestamp: 00060ms SCall: 01285 DCall: 04751 [195.10.230.110:4569]
Rx-Frame Retry[ No] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: POKE
Timestamp: 00007ms SCall: 08934 DCall: 00000 [195.10.230.110:4569]
Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: PONG
Timestamp: 00007ms SCall: 00104 DCall: 08934 [195.10.230.110:4569]
Rx-Frame Retry[ No] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: ACK
Timestamp: 00007ms SCall: 08934 DCall: 00104 [195.10.230.110:4569]
Tx-Frame Retry[000] -- OSeqno: 000 ISeqno: 000 Type: IAX Subclass: POKE
Timestamp: 00012ms SCall: 15728 DCall: 00000 [195.10.230.110:4569]
Rx-Frame Retry[Yes] -- OSeqno: 000 ISeqno: 001 Type: IAX Subclass: PONG
Timestamp: 00000ms SCall: 00001 DCall: 15728 [195.10.230.110:4569]
Tx-Frame Retry[-01] -- OSeqno: 001 ISeqno: 001 Type: IAX Subclass: ACK
Timestamp: 00062ms SCall: 15728 DCall: 00001 [195.10.230.110:4569]
exit
Executing last minute cleanups
[root@pbx ~]#
-
they aren't sending in a DiD (the called number has "s" in it). SARK won't work with that because we use the "s" extension for analogue circuits (much the same as FPBX).
You'll need to seek support from the carrier.
Kind Regards
S