[Freeswitch-users] Dialplan for FS modems - odd behaviour or am I doing it wrong?

Tue Dec 11 21:37:49 MSK 2012

hard to tell its not a complete log, is $1 not the same as what you
captured with the parens?

On Tue, Dec 11, 2012 at 11:19 AM, Alex Crow <acrow at integrafin.co.uk> wrote:

> Hi,
>
> Please see the below log snippet. I am accepting faxes from an ISDN
> gateway on sequential numbers and attempting to route them into distinct
> freeswitch modems by taking the last two digits of the called number
> thusly:
>
>     <condition field="destination_number"
> expression="^12([1-2][0-9]|3[0-6])$">
>          <!--<action application="set" data="ignore_early_media=true"/>-->
>          <action application="set" data="sip_ignore_reinvites=true"/>
>          <action application="set"
> data="absolute_codec_string='PCMA,PCMU'"/>
>          <action application="set" data="jitterbuffer_msec=600:600:60"/>
>          <action application="set" data="sip_jitter_buffer_plc=false"/>
>          <action application="bridge" data="modem/$1/a"/>
>     </condition>
>
> And then have Hylafax email them on depending on which modem they
> arrived on (via FaxDispatch).
>
> However as you can see from the below log snippets, it seems that FS is
> quite happy to change the modem device from what is actually delivered
> via the dialplan. Consequently a number of my faxes are now being routed
> to the wrong people.
>
> Is my bridge dest wrong? Should it be something like modem/$1/0 instead
> of "a"?
>
> Thanks
>
> Alex
>
> Dialplan: sofia/internal/anonymous at anonymous.invalid Action
> set(sip_ignore_reinvites=true)
> Dialplan: sofia/internal/anonymous at anonymous.invalid Action
> set(absolute_codec_string='PCMA,PCMU')
> Dialplan: sofia/internal/anonymous at anonymous.invalid Action
> set(jitterbuffer_msec=600:600:60)
> Dialplan: sofia/internal/anonymous at anonymous.invalid Action
> set(sip_jitter_buffer_plc=false)
> Dialplan: sofia/internal/anonymous at anonymous.invalid Action
> bridge(modem/13/a)
> 2012-12-11 14:43:18.873181 [DEBUG] switch_core_state_machine.c:167
> (sofia/internal/anonymous at anonymous.invalid) State Change CS_ROUTING ->
> CS_EXECUTE
> 2012-12-11 14:43:18.873181 [DEBUG] switch_core_session.c:1283 Send
> signal sofia/internal/anonymous at anonymous.invalid [BREAK]
> 2012-12-11 14:43:18.873181 [DEBUG] switch_core_state_machine.c:470
> (sofia/internal/anonymous at anonymous.invalid) State ROUTING going to sleep
> 2012-12-11 14:43:18.873181 [DEBUG] switch_core_state_machine.c:415
> (sofia/internal/anonymous at anonymous.invalid) Running State Change
> CS_EXECUTE
> 2012-12-11 14:43:18.873181 [DEBUG] switch_core_state_machine.c:477
> (sofia/internal/anonymous at anonymous.invalid) State EXECUTE
> 2012-12-11 14:43:18.873181 [DEBUG] mod_sofia.c:242
> sofia/internal/anonymous at anonymous.invalid SOFIA EXECUTE
> 2012-12-11 14:43:18.873181 [DEBUG] switch_core_state_machine.c:209
> sofia/internal/anonymous at anonymous.invalid Standard EXECUTE
> EXECUTE sofia/internal/anonymous at anonymous.invalidset(call_direction=local)
> 2012-12-11 14:43:18.873181 [DEBUG] mod_dptools.c:1344
> sofia/internal/anonymous at anonymous.invalid SET [call_direction]=[local]
> EXECUTE sofia/internal/anonymous at anonymous.invalid set(open=true)
> 2012-12-11 14:43:18.873181 [DEBUG] mod_dptools.c:1344
> sofia/internal/anonymous at anonymous.invalid SET [open]=[true]
> EXECUTE sofia/internal/anonymous at anonymous.invalid
>
> hash(insert/192.168.20.245-spymap/anonymous/4e5c4699-aa22-4998-b7fa-b50a52c940fb)
> EXECUTE sofia/internal/anonymous at anonymous.invalid
> hash(insert/192.168.20.245-last_dial/anonymous/1213)
> EXECUTE sofia/internal/anonymous at anonymous.invalid
>
> hash(insert/192.168.20.245-last_dial/global/4e5c4699-aa22-4998-b7fa-b50a52c940fb)
> EXECUTE sofia/internal/anonymous at anonymous.invalid set(RFC2822_DATE=Tue,
> 11 Dec 2012 14:43:18 +0000)
> 2012-12-11 14:43:18.873181 [DEBUG] mod_dptools.c:1344
> sofia/internal/anonymous at anonymous.invalid SET [RFC2822_DATE]=[Tue, 11
> Dec 2012 14:43:18 +0000]
> EXECUTE sofia/internal/anonymous at anonymous.invalid
> set(sip_ignore_reinvites=true)
> 2012-12-11 14:43:18.873181 [DEBUG] mod_dptools.c:1344
> sofia/internal/anonymous at anonymous.invalid SET
> [sip_ignore_reinvites]=[true]
> EXECUTE sofia/internal/anonymous at anonymous.invalid
> set(absolute_codec_string='PCMA,PCMU')
> 2012-12-11 14:43:18.873181 [DEBUG] mod_dptools.c:1344
> sofia/internal/anonymous at anonymous.invalid SET
> [absolute_codec_string]=['PCMA,PCMU']
> EXECUTE sofia/internal/anonymous at anonymous.invalid
> set(jitterbuffer_msec=600:600:60)
> 2012-12-11 14:43:18.873181 [DEBUG] mod_dptools.c:1344
> sofia/internal/anonymous at anonymous.invalid SET
> [jitterbuffer_msec]=[600:600:60]
> EXECUTE sofia/internal/anonymous at anonymous.invalid
> set(sip_jitter_buffer_plc=false)
> 2012-12-11 14:43:18.873181 [DEBUG] mod_dptools.c:1344
> sofia/internal/anonymous at anonymous.invalid SET
> [sip_jitter_buffer_plc]=[false]
> EXECUTE sofia/internal/anonymous at anonymous.invalid bridge(modem/13/a)
> 2012-12-11 14:43:18.873181 [DEBUG] switch_channel.c:1089
> sofia/internal/anonymous at anonymous.invalid EXPORTING[export_vars]
> [domain_name]=[192.168.20.245] to event
> 2012-12-11 14:43:18.873181 [DEBUG] switch_ivr_originate.c:2022 Parsing
> global variables
> 2012-12-11 14:43:18.873181 [DEBUG] mod_spandsp_modem.c:1417 Modem
> /dev/FS/FS10 [ONHOOK] - Changing state to ACQUIRED
> 2012-12-11 14:43:18.873181 [NOTICE] switch_channel.c:968 New Channel
> modem/10/a [a202aef1-1628-45e8-b720-9f5368aa4565]
> 2012-12-11 14:43:18.873181 [DEBUG] mod_spandsp_modem.c:769 modem/10/a
> setup codec L16/8000/20
> 2012-12-11 14:43:18.873181 [DEBUG] switch_channel.c:1135 EXPORT
> (export_vars) [rtp_autoflush_during_bridge]=[false]
> 2012-12-11 14:43:18.873181 [DEBUG] mod_spandsp_modem.c:896 (modem/10/a)
> State Change CS_NEW -> CS_INIT
> 2012-12-11 14:43:18.873181 [DEBUG] switch_core_session.c:1283 Send
> signal modem/10/a [BREAK]
> 2012-12-11 14:43:18.873181 [DEBUG] mod_spandsp_modem.c:581 modem/10/a
> CHANNEL KILL
> 2012-12-11 14:43:18.893118 [DEBUG] switch_core_state_machine.c:415
> (modem/10/a) Running State Change CS_INIT
> 2012-12-11 14:43:18.893118 [DEBUG] switch_core_state_machine.c:454
> (modem/10/a) State INIT
> 2012-12-11 14:43:18.893118 [DEBUG] mod_spandsp_modem.c:461 Modem
> /dev/FS/FS10 [ACQUIRED] - Changing state to RINGING
> 2012-12-11 14:43:18.893118 [DEBUG] mod_spandsp_modem.c:1131 Modem
> /dev/FS/FS10 [RINGING] - RNG 1
>
>
> And another one:
>
>
> EXECUTE sofia/internal/anonymous at anonymous.invalid bridge(modem/23/a)
> 2012-12-11 13:42:20.813107 [DEBUG] switch_channel.c:1089
> sofia/internal/anonymous at anonymous.invalid EXPORTING[export_vars]
> [domain_name]=[192.168.20.245] to event
> 2012-12-11 13:42:20.813107 [DEBUG] switch_ivr_originate.c:2022 Parsing
> global variables
> 2012-12-11 13:42:20.813107 [DEBUG] mod_spandsp_modem.c:1417 Modem
> /dev/FS/FS26 [ONHOOK] - Changing state to ACQUIRED
> 2012-12-11 13:42:20.813107 [NOTICE] switch_channel.c:968 New Channel
> modem/26/a [32872ae9-6f78-45b0-af56-4b18c9de7160]
> 2012-12-11 13:42:20.813107 [DEBUG] mod_spandsp_modem.c:769 modem/26/a
> setup codec L16/8000/20
> 2012-12-11 13:42:20.813107 [DEBUG] switch_channel.c:1135 EXPORT
> (export_vars) [rtp_autoflush_during_bridge]=[false]
> 2012-12-11 13:42:20.813107 [DEBUG] mod_spandsp_modem.c:896 (modem/26/a)
> State Change CS_NEW -> CS_INIT
> 2012-12-11 13:42:20.813107 [DEBUG] switch_core_session.c:1283 Send
> signal modem/26/a [BREAK]
> 2012-12-11 13:42:20.813107 [DEBUG] mod_spandsp_modem.c:581 modem/26/a
> CHANNEL KILL
> 2012-12-11 13:42:20.813107 [DEBUG] switch_core_state_machine.c:415
> (modem/26/a) Running State Change CS_INIT
> 2012-12-11 13:42:20.813107 [DEBUG] switch_core_state_machine.c:454
> (modem/26/a) State INIT
> 2012-12-11 13:42:20.813107 [DEBUG] mod_spandsp_modem.c:461 Modem
> /dev/FS/FS26 [ACQUIRED] - Changing state to RINGING
> 2012-12-11 13:42:20.813107 [DEBUG] mod_spandsp_modem.c:1131 Modem
> /dev/FS/FS26 [RINGING] - RNG 1
> 2012-12-11 13:42:20.833137 [DEBUG] mod_spandsp_modem.c:1038 Modem
> /dev/FS/FS26 [RINGING] - Answering
> 2012-12-11 13:42:20.833137 [DEBUG] mod_spandsp_modem.c:1040 Modem
> /dev/FS/FS26 [RINGING] - Changing state to ANSWERED
>
> _________________________________________________________________________
> Professional FreeSWITCH Consulting Services:
> consulting at freeswitch.org
> http://www.freeswitchsolutions.com
>
> 
> 
>
> Official FreeSWITCH Sites
> http://www.freeswitch.org
> http://wiki.freeswitch.org
> http://www.cluecon.com
>
> FreeSWITCH-users mailing list
> FreeSWITCH-users at lists.freeswitch.org
> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users
> UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users
> http://www.freeswitch.org
>

-- 
Anthony Minessale II

FreeSWITCH http://www.freeswitch.org/
ClueCon http://www.cluecon.com/
Twitter: http://twitter.com/FreeSWITCH_wire

AIM: anthm
MSN:anthony_minessale at hotmail.com
GTALK/JABBER/PAYPAL:anthony.minessale at gmail.com
IRC: irc.freenode.net #freeswitch

FreeSWITCH Developer Conference
sip:888 at conference.freeswitch.org
googletalk:conf+888 at conference.freeswitch.org
pstn:+19193869900
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20121211/003154e6/attachment-0001.html 