March 2015 - FreeSWITCH-users - FreeSWITCH Mailing Lists

Fail to ban rule for detecting INVITES with no challenge
by Peter Steinbach 12 Mar '15

12 Mar '15

Hello, we receive a number of Invites from certain IPs, who want to break into our system and call external premium rate numbers Unwanted registers we can block already, but we still have the issue to block specific invites from fraudulent IPs inside the iptables firewall. In the Freeswitch log we see: 2015-03-12 16:54:38.381552 [NOTICE] switch_channel.c:1055 New Channel sofia/internal/149(a)10.11.12.13 [167bb9ee-c8d0-11e4-9f31-b39e581405c5] 2015-03-12 16:54:38.381552 [DEBUG] switch_core_session.c:1061 Send signal sofia/internal/149(a)10.11.12.13 [BREAK] 2015-03-12 16:54:38.381552 [DEBUG] switch_core_session.c:1061 Send signal sofia/internal/149(a)10.11.12.13 [BREAK] 2015-03-12 16:54:38.381552 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/149(a)10.11.12.13) Running State Change CS_NEW 2015-03-12 16:54:38.381552 [DEBUG] sofia.c:8841 sofia/internal/149(a)10.11.12.13 receiving invite from 155.94.64.26:5076 version: 1.5.15b git 82f267a 2015-02-16 22:59:55Z 64bit 2015-03-12 16:54:38.381552 [DEBUG] sofia.c:9008 IP 15.194.164.26 Rejected by acl "domains". Falling back to Digest auth. 2015-03-12 16:54:38.441582 [DEBUG] switch_core_state_machine.c:491 (sofia/internal/149(a)10.11.12.13) State NEW 2015-03-12 16:54:38.441582 [DEBUG] switch_core_session.c:1061 Send signal sofia/internal/149(a)10.11.12.13 [BREAK] 2015-03-12 16:54:38.441582 [DEBUG] sofia.c:2067 detaching session 167bb9ee-c8d0-11e4-9f31-b39e581405c5 2015-03-12 16:54:48.461568 [WARNING] switch_core_state_machine.c:572 167bb9ee-c8d0-11e4-9f31-b39e581405c5 sofia/internal/149(a)10.11.12.13 Abandoned The fraudulent IP here is 15.194.164.26 (anonymized of course). The IP 10.11.12.13 is the (anonymized) IP of our server. The point here is: 15.194.164.26 is sending an INVITE, Freeswitch then sends "authentication required". Freeswitch then logs this entry with "Abandoned" (see last line above) and that's it. So Is there any way to make Freeswitch show up a log line with the fraudulent IP 15.194.164.26 and some text like "abandonned"? Example for extending a current log line 2015-03-12 16:54:48.461568 [WARNING] switch_core_state_machine.c:572 167bb9ee-c8d0-11e4-9f31-b39e581405c5 sofia/internal/149(a)10.11.12.13 Abandoned for IP 15.194.164.26 This would enable us to process this entry with fail2ban and block this IP in the Firewall. Any other hint is welcome. -- With kind regards Marvin Keil Telefaks Services GmbH mailto:lists (att) telefaks.de Internet: www.telefaks.de

7 11

Realtime sip registrations
by Richard Mace 12 Mar '15

12 Mar '15

Hi All, Is it possible to see when sip registrations happen in real time? Thanks Richard

6 6

ESL object taking large memory
by DP Siddharth 12 Mar '15

12 Mar '15

Hi All, I am working on python/esl based server. We are seeing memory getting increase by ~6.5MB when con = ESLconnection() get called. We tried to cleanup this object as soon calls gets complete, but somehow we are not successful. Further looking into esl/src/include/esl.h we found #define BUF_CHUNK 65536 * 50 #define BUF_START 65536 * 100 modifying these values help in controlling python server memory growth. Can someone help me in understanding why we have this buffer size of 6.5MB? -- Thanks & Regards, D P Siddharth Director (Platform) Knowlarity Communications Ph: +919999115231 dp.siddharth(a)eng.knowlarity.com <emailID(a)knowlarity.com> *"Come together to build a lasting world-class cloud telephony company that helps businesses grow"*

2 3

Aastra 9133i phones Intercom/AutoAnswer w/FreeSWITCH
by T Fred Farmington 12 Mar '15

12 Mar '15

Hello, My current challenge is getting the AutoAnswer to work on the 9133i phones to support Intercom functionality. Within the conf/dialplan/default.xml file I am basically using the FreeSWITCH default settings <extension name = "extension-intercom"> <condition field = "destination_number" expression = "^8(1[012][0-9])|8(10[012][0-9])$">  <action application = "set" data = "dialed_extension=$1"/> <action application = "export" data = "sip_auto_answer=true"/> <action application = "bridge" data = "user/${dialed_extension}@${domain_name}"/> </condition> </extension> The AutoAnswer is working on the single Aastra 6731i phone that I have in the system, but not on any of the 9133i phones. This is in spite of both phone models have the Auto-Answer parameter set in their individual internal configurations. 9133i: Incoming Intercom Settings -- Auto-Answer -- Enabled 6731i: Incoming Intercom Settings -- Auto-Answer -- Enabled NOTE - the 9133i extension's will ring, but not go into the AutoAnswer/Speaker/Intercom mode While searching the web for an answer I came across an old posting (Feb 11, 2011) where Tim St. Pierre indicates that he has a relatively large FreeSWITCH phone system incorporating a number of Aastra models. He goes on to say that he has Intercom calls (auto-answer to speaker phone) working on the 9133i phones (among others) I'd appreciate any advice anyone might have so that I can get the FreeSWITCH Intercom auto-answer working on the 9133i phones as well. Thanks, TF

1 0

blf status stress testing
by Raphael Lechner 12 Mar '15

12 Mar '15

Hi, We have the problem that on different installations the blf keys in combination with yealink phones don’t always show the correct status, sometimes ringing or busy is not shown. The installations are relative small from 3 to 80 Phones. We still have the V72 Version of firmware on the phones and not all installations have the current 1.4.15 version of FreeSWITCH. I’m trying to build some kind of stress test environment to try to reproduce the issue do identify if the problem is resolved with the new phone firmware and FreeSWITCH version or to identify what is going wrong. Can someone recommend tools for stress testing the blf keys? Thank you, Raphael

3 4

Chrome 42 Beta (on Windows) not working with FreeSWITCH
by Oleg Stolyar 11 Mar '15

11 Mar '15

Hi guys, I just got Chrome 42 beta and it does not work with FreeSWITCH. I am getting this error on FS: 2015-03-10 19:04:12.272683 [ERR] switch_rtp.c:2800 audio DTLS packet not written I tested it with the FS Verto test site and it also does not work. https://webrtc.freeswitch.org/verto/index.html#page-main Is this a known issue? Of course 42 Beta also does not recognize Java for me, so hopefully it's just a crappy build and Google will fix it but my concern is that other WebRTC test sites still work, so should we look into this in case it's not fixed by the time Chrome 42 becomes stable?

5 10

xml_cdr encoding issues
by Assaf Dahary 11 Mar '15

11 Mar '15

Hi, I have installed a fresh FS on a DigitalOcean VPS (CentOS 6.5 64bit). FreeSWITCH Version 1.5.15b+git~20150303T230402Z~86c68d906a~64bit (git 86c68d9 2015-03-03 23:04:02Z 64bit) I'm using mod_cml_cdr to process call logs into DB using a PHP script ($xml = simplexml_load_string($xml_string);) The problem is that the xml parsing is failing because the generated POST XML CDR string received on my web is NOT url-encoded as should be. I verified that encoding is enabled: <param name="encode" value="true"/> (see full conf file below). This un-encoded line from the posted xml CDR is one example for what is causing the xml parsing error: <sip_full_from>"99252627" <sip:1234@11.11.11.11>;tag=y3Xr3g6HZZtBQ</sip_full_from>. On other FS I get it encoded with no xml errors: <sip_full_from>%3Csip%3A1234%40abc.com%3E%3Btag%3DnQGk6NEXS0yYrSeyIYCbrXmge7 80R7J4</sip_full_from> I've reinstalled all PHP/XML/CURL related modules with no help. I also tried to post to my other FS web server thinking that the local FS web is decoding and then passing to the php xml script - still with no help. Any tip/help/advise will be appreciated. Regards Assaf This is my xml_cdr.conf.xml file: <configuration name="xml_cdr.conf" description="XML CDR CURL logger"> <settings>           <param name="log-dir" value=""/>   <param name="log-b-leg" value="false"/>   <param name="prefix-a-leg" value="true"/>  <param name="encode" value="true"/>         </settings> </configuration>

2 2

Caller ID not logged in CDR properly
by Alexander Baldeck 11 Mar '15

11 Mar '15

Hello, we are using Freeswitch 1.5.12b+git~20140324T234505Z~4dd0a5848f~64bit interfacing it with Plivo and experience an issue where our call detail records list the destination_number twice when someone picks up a call like so: "Outbound Call","99901637777777","99901637777777","default","2015-02-28 13:15:00","2015-02-28 13:15:08","2015-02-28 13:16:32","92","84","NORMAL_CLEARING","24fdbb20-32a3-11e4-b883-e58f73531fe4","","","PCMA","PCMA" If the call isn't picked up upon though, everything is alright and caller_id_number is logged alongside destination_number like so: "","0123456789","99901637777777","default","2015-02-28 13:11:00","","2015-02-28 13:12:00","60","0","NO_ANSWER","95b050f4-32a2-11e4-b87f-e58f73531fe4","","","","" The used template in cdr_csv.xml looks like this and I made sure it is being used: <template name="example">"${caller_id_name}","${caller_id_number}","${destination_number}","${context}","${start_stamp}","${answer_stamp}","${end_stamp}","${duration}","${billsec}","${hangup_cause}","${uuid}","${bleg_uuid}","${accountcode}","${read_codec}","${write_codec}"</template> I'm at a loss what's going on here, has anyone got insight on where to look? Best, Alex This email and its contents are confidential and may not be shared. If you are not the intended recipient of this email, please discard it. Please do not copy, forward, disclose, or use any part of it. Please delete it and all copies from your system and please notify the sender immediately by return e-mail. Thank you very much for your cooperation.

2 1

How to configure G722 for internal and G729 for external calls
by Jason Lewis 11 Mar '15

11 Mar '15

hi, I'm trying to get freeswitch to use G722 for internal calls and G729 for external calls. I'm using vanilla. Am I missing something obvious here? in vars.xml I have: <X-PRE-PROCESS cmd="set" data="global_codec_prefs=OPUS,G722,PCMU,PCMA,GSM"/> <X-PRE-PROCESS cmd="set" data="outbound_codec_prefs=G729"/> when I place a call to an external number, it gets encoded as G722, according to the CDR: "1001","1001","938xxxxxx","default","2015-03-09 16:52:45","2015-03-09 16:52:48","2015-03-09 16:54:03","78","75","NORMAL_CLEARING","1ee1cfd1-f35c-4829-803a-771678574d07","cb8ee2cc-46bb-45d2-b302-effe038f195e","1001","G722","G722" Dialplan: <extension name="pennytel-local_fixed_line"> <condition field="destination_number" expression="^([2-9]{1}[0-9]{7})$"> <action application="set" data="sip_h_X-accountcode=${accountcode}"/> <action application="set" data="call_direction=outbound"/> <action application="set" data="hangup_after_bridge=true"/> <action application="set" data="effective_caller_id_name=${outbound_caller_id_name}"/> <action application="set" data="effective_caller_id_number=${outbound_caller_id_number}"/> <action application="bridge" data="{absolute_codec_string='G729'}sofia/gateway/pennytel/612$1"/> </condition> </extension> restarting the external gateway shows the outbound codec preference is there: freeswitch@internal> sofia profile external restart reloadxml Reload XML [Success] restarting: external freeswitch@internal> 2015-03-10 12:33:04.175760 [INFO] mod_enum.c:880 ENUM Reloaded 2015-03-10 12:33:04.175760 [INFO] switch_time.c:1411 Timezone reloaded 1781 definitions 2015-03-10 12:33:04.315790 [NOTICE] sofia_reg.c:135 UN-Registering sip2sip 2015-03-10 12:33:04.315790 [NOTICE] sofia_reg.c:135 UN-Registering pennytel 2015-03-10 12:33:05.315785 [NOTICE] sofia.c:3044 Waiting for worker thread 2015-03-10 12:33:05.315785 [INFO] switch_core_sqldb.c:1701 sofia:external Destroying SQL queue. 2015-03-10 12:33:05.515828 [INFO] switch_core_sqldb.c:1664 sofia:external Stopping SQL thread. 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:3099 Write lock external 2015-03-10 12:33:05.515828 [NOTICE] sofia_glue.c:1814 deleted gateway example.com from profile external 2015-03-10 12:33:05.515828 [NOTICE] sofia_glue.c:1814 deleted gateway sip2sip from profile external 2015-03-10 12:33:05.515828 [NOTICE] sofia_glue.c:1814 deleted gateway pennytel from profile external 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:3112 Write unlock external 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 debug [0] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 sip-trace [no] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 sip-capture [no] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 rfc2833-pt [101] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 sip-port [5080] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 dialplan [XML] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 context [public] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 dtmf-duration [2000] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 inbound-codec-prefs [OPUS,G722,PCMU,PCMA,GSM] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 outbound-codec-prefs [G729] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 hold-music [local_stream://moh/8000] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 rtp-timer-name [soft] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 local-network-acl [localnet.auto] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 manage-presence [false] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 inbound-codec-negotiation [generous] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 nonce-ttl [60] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 auth-calls [false] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 inbound-late-negotiation [true] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 inbound-zrtp-passthru [true] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 rtp-ip [10.0.2.145] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 sip-ip [10.0.2.145] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 ext-rtp-ip [aa.bb.cc.dd] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 ext-sip-ip [aa.bb.cc.dd] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 rtp-timeout-sec [300] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 rtp-hold-timeout-sec [1800] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 tls [false] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 tls-only [false] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 tls-bind-params [transport=tls] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 tls-sip-port [5081] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 tls-passphrase [] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 tls-verify-date [true] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 tls-verify-policy [none] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 tls-verify-depth [2] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 tls-verify-in-subjects [] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:4146 tls-version [tlsv1,tlsv1.1,tlsv1.2] 2015-03-10 12:33:05.515828 [NOTICE] sofia.c:5557 Started Profile external [sofia_reg_external] 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:2755 Creating agent for external 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:2873 Created agent for external 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:2918 Set params for external 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:2962 Activated db for external 2015-03-10 12:33:05.515828 [INFO] switch_core_sqldb.c:1679 sofia:external Starting SQL thread. 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:3000 Starting thread for external 2015-03-10 12:33:05.515828 [DEBUG] sofia.c:2655 Launching worker thread for external 2015-03-10 12:33:05.515828 [NOTICE] sofia_reg.c:3329 Added gateway 'pennytel' to profile 'external' 2015-03-10 12:33:05.515828 [NOTICE] sofia_reg.c:3329 Added gateway 'sip2sip' to profile 'external' 2015-03-10 12:33:05.515828 [NOTICE] sofia_reg.c:3329 Added gateway 'example.com' to profile 'external' 2015-03-10 12:33:05.515828 [NOTICE] sofia_reg.c:448 Registering sip2sip 2015-03-10 12:33:05.515828 [NOTICE] sofia_reg.c:448 Registering pennytel Dialing out, I get these logs: 2015-03-10 12:37:37.615813 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:37.615813 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:37.615813 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1001(a)freeswitch.xyz.com.au) Running State Change CS_NEW 2015-03-10 12:37:37.635769 [DEBUG] sofia.c:8834 sofia/internal/1001(a)freeswitch.xyz.com.au receiving invite from 10.0.2.129:5062 version: 1.4.15 -1 64bit 2015-03-10 12:37:37.635769 [DEBUG] sofia.c:9001 IP 10.0.2.129 Rejected by acl "domains". Falling back to Digest auth. 2015-03-10 12:37:37.635769 [DEBUG] switch_core_state_machine.c:491 (sofia/internal/1001(a)freeswitch.xyz.com.au) State NEW 2015-03-10 12:37:37.635769 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:37.635769 [DEBUG] sofia.c:2067 detaching session 38291425-a146-4aa2-a129-854757744bc1 2015-03-10 12:37:37.755808 [DEBUG] sofia.c:2175 Re-attaching to session 38291425-a146-4aa2-a129-854757744bc1 2015-03-10 12:37:37.755808 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:37.755808 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:37.775786 [DEBUG] sofia.c:8834 sofia/internal/1001(a)freeswitch.xyz.com.au receiving invite from 10.0.2.129:5062 version: 1.4.15 -1 64bit 2015-03-10 12:37:37.775786 [DEBUG] sofia.c:9001 IP 10.0.2.129 Rejected by acl "domains". Falling back to Digest auth. 2015-03-10 12:37:37.775786 [DEBUG] sofia.c:6614 Channel sofia/internal/1001(a)freeswitch.xyz.com.au entering state [received][100] 2015-03-10 12:37:37.775786 [DEBUG] sofia.c:6624 Remote SDP: v=0 o=- 20183 20183 IN IP4 10.0.2.129 s=SDP data c=IN IP4 10.0.2.129 t=0 0 m=audio 11794 RTP/AVP 18 9 0 8 101 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:9 G722/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:20 2015-03-10 12:37:37.775786 [DEBUG] sofia.c:6890 (sofia/internal/1001(a)freeswitch.xyz.com.au) State Change CS_NEW -> CS_INIT 2015-03-10 12:37:37.775786 [DEBUG] switch_core_session.c:1388 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1001(a)freeswitch.xyz.com.au) Running State Change CS_INIT 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:512 (sofia/internal/1001(a)freeswitch.xyz.com.au) State INIT 2015-03-10 12:37:37.775786 [DEBUG] mod_sofia.c:87 sofia/internal/1001(a)freeswitch.xyz.com.au SOFIA INIT 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:40 sofia/internal/1001(a)freeswitch.xyz.com.au Standard INIT 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/1001(a)freeswitch.xyz.com.au) State Change CS_INIT -> CS_ROUTING 2015-03-10 12:37:37.775786 [DEBUG] switch_core_session.c:1388 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:512 (sofia/internal/1001(a)freeswitch.xyz.com.au) State INIT going to sleep 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1001(a)freeswitch.xyz.com.au) Running State Change CS_ROUTING 2015-03-10 12:37:37.775786 [DEBUG] switch_channel.c:2184 (sofia/internal/1001(a)freeswitch.xyz.com.au) Callstate Change DOWN -> RINGING 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:528 (sofia/internal/1001(a)freeswitch.xyz.com.au) State ROUTING 2015-03-10 12:37:37.775786 [DEBUG] mod_sofia.c:123 sofia/internal/1001(a)freeswitch.xyz.com.au SOFIA ROUTING 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:166 sofia/internal/1001(a)freeswitch.xyz.com.au Standard ROUTING 2015-03-10 12:37:37.775786 [INFO] mod_dialplan_xml.c:635 Processing 1001 <1001>->775 in context default Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->unloop] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (PASS) [unloop] ${unroll_loops}(true) =~ /^true$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [unloop] ${sip_looped_call}() =~ /^true$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->tod_example] continue=true Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Date/Time Match (PASS) [tod_example] break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Action set(open=true) Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->holiday_example] continue=true Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Date/TimeMatch (FAIL) [holiday_example] break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->global-intercept] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [global-intercept] destination_number(775) =~ /^886$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->group-intercept] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [group-intercept] destination_number(775) =~ /^\*8$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->intercept-ext] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [intercept-ext] destination_number(775) =~ /^\*\*(\d+)$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->redial] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [redial] destination_number(775) =~ /^(redial|870)$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->global] continue=true Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [global] ${call_debug}(false) =~ /^true$/ break=never Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [global] ${default_password}(18651) =~ /^1234$/ break=never Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [global] ${rtp_has_crypto}() =~ /^(AEAD_AES_256_GCM_8|AEAD_AES_128_GCM_8|AES_CM_256_HMAC_SHA1_80|AES_CM_192_HMAC_SHA1_80|AES_CM_128_HMAC_SHA1_80|AES_CM_256_HMAC_SHA1_32|AES_CM_192_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_32|AES_CM_128_NULL_AUTH)$/ break=never Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (PASS) [global] ${endpoint_disposition}(DELAYED NEGOTIATION) =~ /^(DELAYED NEGOTIATION)/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [global] ${switch_r_sdp}(v=0 o=- 20183 20183 IN IP4 10.0.2.129 s=SDP data c=IN IP4 10.0.2.129 t=0 0 m=audio 11794 RTP/AVP 18 9 0 8 101 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:9 G722/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:20 ) =~ /(AES_CM_128_HMAC_SHA1_32|AES_CM_128_HMAC_SHA1_80)/ break=never Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Absolute Condition [global] Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Action hash(insert/${domain_name}-last_dial/global/${uuid}) Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Action export(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->snom-demo-2] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [snom-demo-2] destination_number(775) =~ /^9001$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->snom-demo-1] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [snom-demo-1] destination_number(775) =~ /^9000$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->eavesdrop] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [eavesdrop] destination_number(775) =~ /^88(\d{4})$|^\*0(.*)$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->eavesdrop] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [eavesdrop] destination_number(775) =~ /^779$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->call_return] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [call_return] destination_number(775) =~ /^\*69$|^869$|^lcr$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->del-group] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [del-group] destination_number(775) =~ /^80(\d{2})$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->add-group] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [add-group] destination_number(775) =~ /^81(\d{2})$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->call-group-simo] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [call-group-simo] destination_number(775) =~ /^82(\d{2})$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->call-group-order] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [call-group-order] destination_number(775) =~ /^83(\d{2})$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->extension-intercom] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [extension-intercom] destination_number(775) =~ /^8(10[01][0-9])$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->SIPTAPI-AutoAnswer] continue=true Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [SIPTAPI-AutoAnswer] ${sip_user_agent}(Yealink SIP-T42G 29.73.0.45) =~ /.*SIPTAPI.*/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->Local_Extension] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [Local_Extension] destination_number(775) =~ /^(10[01][0-9])$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->Local_Extension_Skinny] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [Local_Extension_Skinny] destination_number(775) =~ /^(11[01][0-9])$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->group_dial_sales] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [group_dial_sales] destination_number(775) =~ /^2000$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->group_dial_support] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [group_dial_support] destination_number(775) =~ /^2001$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->group_dial_billing] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [group_dial_billing] destination_number(775) =~ /^2002$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->group_dial_custom] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [group_dial_custom] destination_number(775) =~ /^2003$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->operator] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [operator] destination_number(775) =~ /^(operator|0)$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->vmain] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [vmain] destination_number(775) =~ /^vmain$|^4000$|^\*98$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->sip_uri] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [sip_uri] destination_number(775) =~ /^sip:(.*)$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->nb_conferences] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [nb_conferences] destination_number(775) =~ /^(30\d{2})$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->wb_conferences] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [wb_conferences] destination_number(775) =~ /^(31\d{2})$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->uwb_conferences] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [uwb_conferences] destination_number(775) =~ /^(32\d{2})$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->cdquality_conferences] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [cdquality_conferences] destination_number(775) =~ /^(33\d{2})$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->freeswitch_public_conf_via_sip] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [freeswitch_public_conf_via_sip] destination_number(775) =~ /^9(888|8888|1616|3232)$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->mad_boss_intercom] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [mad_boss_intercom] destination_number(775) =~ /^0911$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->mad_boss_intercom] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [mad_boss_intercom] destination_number(775) =~ /^0912$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->mad_boss] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [mad_boss] destination_number(775) =~ /^0913$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->ivr_demo] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [ivr_demo] destination_number(775) =~ /^5000$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->dynamic_conference] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [dynamic_conference] destination_number(775) =~ /^5001$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->rtp_multicast_page] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [rtp_multicast_page] destination_number(775) =~ /^pagegroup$|^7243$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->park] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [park] destination_number(775) =~ /^5900$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->unpark] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [unpark] destination_number(775) =~ /^5901$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->valet_park] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [valet_park] destination_number(775) =~ /^(6000)$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->valet_park] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [valet_park] destination_number(775) =~ /^((?!6000)60\d{2})$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->park] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (PASS) [park] source(mod_sofia) =~ /mod_sofia/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [park] destination_number(775) =~ /park\+(\d+)/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->unpark] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (PASS) [unpark] source(mod_sofia) =~ /mod_sofia/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [unpark] destination_number(775) =~ /^parking$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->park] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (PASS) [park] source(mod_sofia) =~ /mod_sofia/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [park] destination_number(775) =~ /callpark/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->unpark] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (PASS) [unpark] source(mod_sofia) =~ /mod_sofia/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [unpark] destination_number(775) =~ /pickup/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->wait] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [wait] destination_number(775) =~ /^wait$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->fax_receive] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [fax_receive] destination_number(775) =~ /^9178$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->fax_transmit] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [fax_transmit] destination_number(775) =~ /^9179$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->ringback_180] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [ringback_180] destination_number(775) =~ /^9180$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->ringback_183_uk_ring] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [ringback_183_uk_ring] destination_number(775) =~ /^9181$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->ringback_183_music_ring] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [ringback_183_music_ring] destination_number(775) =~ /^9182$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->ringback_post_answer_uk_ring] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [ringback_post_answer_uk_ring] destination_number(775) =~ /^9183$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->ringback_post_answer_music] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [ringback_post_answer_music] destination_number(775) =~ /^9184$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->ClueCon] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [ClueCon] destination_number(775) =~ /^9191$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->show_info] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [show_info] destination_number(775) =~ /^9192$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->video_record] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [video_record] destination_number(775) =~ /^9193$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->video_playback] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [video_playback] destination_number(775) =~ /^9194$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->delay_echo] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [delay_echo] destination_number(775) =~ /^9195$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->echo] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [echo] destination_number(775) =~ /^9196$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->milliwatt] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [milliwatt] destination_number(775) =~ /^9197$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->tone_stream] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [tone_stream] destination_number(775) =~ /^9198$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->zrtp_enrollement] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [zrtp_enrollement] destination_number(775) =~ /^9787$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->hold_music] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [hold_music] destination_number(775) =~ /^9664$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->laugh break] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [laugh break] destination_number(775) =~ /^9386$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->101] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [101] destination_number(775) =~ /^101$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->pizza_demo] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [pizza_demo] destination_number(775) =~ /^(pizza|74992)$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->Talking Clock Time] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [Talking Clock Time] destination_number(775) =~ /^9170$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->Talking Clock Date] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [Talking Clock Date] destination_number(775) =~ /^9171$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->Talking Clock Date and Time] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [Talking Clock Date and Time] destination_number(775) =~ /^9172$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->pennytel-local_fixed_line] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [pennytel-local_fixed_line] destination_number(775) =~ /^([2-9]{1}[0-9]{7})$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->pennytel-national_fixed_line] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [pennytel-national_fixed_line] destination_number(775) =~ /^(0|61|\+61)?([2?|3|5-9]{1}[0-9]{8})$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->pennytel-national_mobiles] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [pennytel-national_mobiles] destination_number(775) =~ /^(0|61|\+61)?(4{1}[0-9]{8})$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->pennytel-13] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [pennytel-13] destination_number(775) =~ /^13(\d{4}|00\d{6})$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->pennytel-18] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (FAIL) [pennytel-18] destination_number(775) =~ /^180(\d{4}|0\d{6})$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au parsing [default->pennytel-test] continue=false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Regex (PASS) [pennytel-test] destination_number(775) =~ /^775$/ break=on-false Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Action set(sip_h_X-accountcode=${accountcode}) Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Action set(call_direction=outbound) Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Action set(hangup_after_bridge=true) Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Action set(effective_caller_id_name=${outbound_caller_id_name}) Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Action set(effective_caller_id_number=${outbound_caller_id_number}) Dialplan: sofia/internal/1001(a)freeswitch.xyz.com.au Action bridge({absolute_codec_string='G729'}sofia/gateway/pennytel/775) 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:216 (sofia/internal/1001(a)freeswitch.xyz.com.au) State Change CS_ROUTING -> CS_EXECUTE 2015-03-10 12:37:37.775786 [DEBUG] switch_core_session.c:1388 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:528 (sofia/internal/1001(a)freeswitch.xyz.com.au) State ROUTING going to sleep 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1001(a)freeswitch.xyz.com.au) Running State Change CS_EXECUTE 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:535 (sofia/internal/1001(a)freeswitch.xyz.com.au) State EXECUTE 2015-03-10 12:37:37.775786 [DEBUG] mod_sofia.c:178 sofia/internal/1001(a)freeswitch.xyz.com.au SOFIA EXECUTE 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:258 sofia/internal/1001(a)freeswitch.xyz.com.au Standard EXECUTE EXECUTE sofia/internal/1001(a)freeswitch.xyz.com.au set(open=true) 2015-03-10 12:37:37.775786 [DEBUG] mod_dptools.c:1435 sofia/internal/1001(a)freeswitch.xyz.com.au SET [open]=[true] EXECUTE sofia/internal/1001(a)freeswitch.xyz.com.au hash(insert/freeswitch.xyz.com.au-spymap/1001/38291425-a146-4aa2-a129-854757744bc1) EXECUTE sofia/internal/1001(a)freeswitch.xyz.com.au hash(insert/freeswitch.xyz.com.au-last_dial/1001/775) EXECUTE sofia/internal/1001(a)freeswitch.xyz.com.au hash(insert/freeswitch.xyz.com.au-last_dial/global/38291425-a146-4aa2-a129-854757744bc1) EXECUTE sofia/internal/1001(a)freeswitch.xyz.com.au export(RFC2822_DATE=Tue, 10 Mar 2015 12:37:37 +1100) 2015-03-10 12:37:37.775786 [DEBUG] switch_channel.c:1247 EXPORT (export_vars) [RFC2822_DATE]=[Tue, 10 Mar 2015 12:37:37 +1100] EXECUTE sofia/internal/1001(a)freeswitch.xyz.com.au set(sip_h_X-accountcode=1001) 2015-03-10 12:37:37.775786 [DEBUG] mod_dptools.c:1435 sofia/internal/1001(a)freeswitch.xyz.com.au SET [sip_h_X-accountcode]=[1001] EXECUTE sofia/internal/1001(a)freeswitch.xyz.com.au set(call_direction=outbound) 2015-03-10 12:37:37.775786 [DEBUG] mod_dptools.c:1435 sofia/internal/1001(a)freeswitch.xyz.com.au SET [call_direction]=[outbound] EXECUTE sofia/internal/1001(a)freeswitch.xyz.com.au set(hangup_after_bridge=true) 2015-03-10 12:37:37.775786 [DEBUG] mod_dptools.c:1435 sofia/internal/1001(a)freeswitch.xyz.com.au SET [hangup_after_bridge]=[true] EXECUTE sofia/internal/1001(a)freeswitch.xyz.com.au set(effective_caller_id_name=FreeSWITCH) 2015-03-10 12:37:37.775786 [DEBUG] mod_dptools.c:1435 sofia/internal/1001(a)freeswitch.xyz.com.au SET [effective_caller_id_name]=[FreeSWITCH] EXECUTE sofia/internal/1001(a)freeswitch.xyz.com.au set(effective_caller_id_number=0000000000) 2015-03-10 12:37:37.775786 [DEBUG] mod_dptools.c:1435 sofia/internal/1001(a)freeswitch.xyz.com.au SET [effective_caller_id_number]=[0000000000] EXECUTE sofia/internal/1001(a)freeswitch.xyz.com.au bridge({absolute_codec_string='G729'}sofia/gateway/pennytel/775) 2015-03-10 12:37:37.775786 [DEBUG] switch_channel.c:1201 sofia/internal/1001(a)freeswitch.xyz.com.au EXPORTING[export_vars] [RFC2822_DATE]=[Tue, 10 Mar 2015 12:37:37 +1100] to event 2015-03-10 12:37:37.775786 [DEBUG] switch_ivr_originate.c:2103 Parsing global variables 2015-03-10 12:37:37.775786 [DEBUG] switch_event.c:1688 Parsing variable [absolute_codec_string]=[G729] 2015-03-10 12:37:37.775786 [NOTICE] switch_channel.c:1055 New Channel sofia/external/775 [a6bc5be8-d538-4b72-892f-6e7c26f6dea6] 2015-03-10 12:37:37.775786 [DEBUG] mod_sofia.c:4627 (sofia/external/775) State Change CS_NEW -> CS_INIT 2015-03-10 12:37:37.775786 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:37.775786 [DEBUG] mod_sofia.c:4697 [zrtp_passthru] Setting a-leg inherit_codec=true 2015-03-10 12:37:37.775786 [DEBUG] mod_sofia.c:4700 [zrtp_passthru] Setting b-leg absolute_codec_string='G722@8000h@20i@64000b,PCMU@8000h@20i@64000b,PCMA@8000h@20i@64000b' 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:472 (sofia/external/775) Running State Change CS_INIT 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:512 (sofia/external/775) State INIT 2015-03-10 12:37:37.775786 [DEBUG] mod_sofia.c:87 sofia/external/775 SOFIA INIT 2015-03-10 12:37:37.775786 [DEBUG] sofia_glue.c:1232 sofia/external/775 sending invite version: 1.4.15 -1 64bit Local SDP: v=0 o=FreeSWITCH 1425927473 1425927474 IN IP4 aa.bbb.ccc.ddd s=FreeSWITCH c=IN IP4 aa.bbb.ccc.ddd t=0 0 m=audio 23984 RTP/AVP 18 101 13 a=rtpmap:18 G729/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:40 sofia/external/775 Standard INIT 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:48 (sofia/external/775) State Change CS_INIT -> CS_ROUTING 2015-03-10 12:37:37.775786 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:512 (sofia/external/775) State INIT going to sleep 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:472 (sofia/external/775) Running State Change CS_ROUTING 2015-03-10 12:37:37.775786 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:37.775786 [DEBUG] sofia.c:6614 Channel sofia/external/775 entering state [calling][0] 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:528 (sofia/external/775) State ROUTING 2015-03-10 12:37:37.775786 [DEBUG] mod_sofia.c:123 sofia/external/775 SOFIA ROUTING 2015-03-10 12:37:37.775786 [DEBUG] switch_ivr_originate.c:67 (sofia/external/775) State Change CS_ROUTING -> CS_CONSUME_MEDIA 2015-03-10 12:37:37.775786 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:528 (sofia/external/775) State ROUTING going to sleep 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:472 (sofia/external/775) Running State Change CS_CONSUME_MEDIA 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:547 (sofia/external/775) State CONSUME_MEDIA 2015-03-10 12:37:37.775786 [DEBUG] switch_core_state_machine.c:547 (sofia/external/775) State CONSUME_MEDIA going to sleep 2015-03-10 12:37:38.315813 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:38.315813 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:38.315813 [DEBUG] sofia.c:6614 Channel sofia/external/775 entering state [calling][0] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:38.735794 [DEBUG] sofia.c:6614 Channel sofia/external/775 entering state [completing][200] 2015-03-10 12:37:38.735794 [DEBUG] sofia.c:6624 Remote SDP: v=0 o=Sippy 2433467651418324771 2 IN IP4 202.85.243.105 s=session t=0 0 m=audio 10948 RTP/AVP 18 101 c=IN IP4 202.85.243.53 a=rtpmap:18 G729/8000 a=fmtp:18 annexb=no a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 2015-03-10 12:37:38.735794 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_session.c:1053 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:38.735794 [DEBUG] sofia.c:6614 Channel sofia/external/775 entering state [ready][200] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [G729:18:8000:20:8000:1]/[G729:18:8000:20:8000:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3682 Audio Codec Compare [G729:18:8000:20:8000:1] ++++ is saved as a match 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3543 Set telephone-event payload to 101 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:2473 Set Codec sofia/external/775 G729/8000 20 ms 160 samples 8000 bits 1 channels 2015-03-10 12:37:38.735794 [DEBUG] switch_core_codec.c:111 sofia/external/775 Original read codec set to G729:18 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3881 Set 2833 dtmf send payload to 101 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:5141 AUDIO RTP [sofia/external/775] 10.0.2.145 port 23984 -> 202.85.243.53 port 10948 codec: 18 ms: 20 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:3548 Starting timer [soft] 160 bytes per 20ms 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: START SESSION INITIALIZATION. sID=61. 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: ZID=306130303032393164366363. 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: Loading User's profile: 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: allowclear: OFF 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: autosecure: ON 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: disclose_bit: OFF 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: signal. role: Initiator 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: TTL: 4294967295 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: SAS schemes: 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 B256 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 B32 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: Ciphers: 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 AES3 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 AES1 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: PK schemes: 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 EC25 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 DH3k 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 DH2k 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 Mult 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: ATL: 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 HS32 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: Hashes: 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 S256 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: Session initialization - DONE. sID=61. 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: ATTACH NEW STREAM to sID=61: 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp]: Stream ID=0 UNKNOWN switching <NONE> ---> <ACTIVE>. 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: Empty slot was found - initializing new stream with ID=61. 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: Preparing ZRTP Hello according to the Session profile. 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp main]: ATTACH NEW STREAM - DONE. 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp engine]: START STREAM ID=61 mode=CLEAR state=ACTIVE. 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp]: Stream ID=61 CLEAR switching <ACTIVE> ---> <START>. 2015-03-10 12:37:38.735794 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6662 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:5439 Set 2833 dtmf send payload to 101 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:5445 Set 2833 dtmf receive payload to 101 2015-03-10 12:37:38.735794 [DEBUG] switch_channel.c:3635 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:38.735794 [NOTICE] sofia.c:7475 Channel [sofia/external/775] has been answered 2015-03-10 12:37:38.735794 [DEBUG] switch_channel.c:3689 (sofia/external/775) Callstate Change DOWN -> ACTIVE 2015-03-10 12:37:38.735794 [DEBUG] switch_ivr_originate.c:415 Codec string G729@8000h@20i not supported on sofia/internal/1001(a)freeswitch.xyz.com.au, skipping inheritance 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [G729:18:8000:20:8000:1]/[opus:116:48000:20:0:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [G729:18:8000:20:8000:1]/[G722:9:8000:20:64000:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMU:0:8000:20:64000:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [G729:18:8000:20:8000:1]/[PCMA:8:8000:20:64000:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [G729:18:8000:20:8000:1]/[GSM:3:8000:20:13200:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [G722:9:8000:20:64000:1]/[opus:116:48000:20:0:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3682 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [G722:9:8000:20:64000:1]/[GSM:3:8000:20:13200:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3682 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[GSM:3:8000:20:13200:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[opus:116:48000:20:0:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[G722:9:8000:20:64000:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3682 Audio Codec Compare [PCMA:8:8000:20:64000:1] ++++ is saved as a match 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [PCMA:8:8000:20:64000:1]/[GSM:3:8000:20:13200:1] 2015-03-10 12:37:38.735794 [DEBUG] switch_core_media.c:3543 Set telephone-event payload to 101 2015-03-10 12:37:38.755785 [DEBUG] switch_core_media.c:2473 Set Codec sofia/internal/1001(a)freeswitch.xyz.com.au G722/8000 20 ms 160 samples 64000 bits 1 channels 2015-03-10 12:37:38.755785 [DEBUG] switch_core_codec.c:111 sofia/internal/1001(a)freeswitch.xyz.com.au Original read codec set to G722:9 2015-03-10 12:37:38.755785 [DEBUG] switch_core_media.c:3890 Set 2833 dtmf send/recv payload to 101 2015-03-10 12:37:38.755785 [DEBUG] switch_core_media.c:5141 AUDIO RTP [sofia/internal/1001(a)freeswitch.xyz.com.au] 10.0.2.145 port 20762 -> 10.0.2.129 port 11794 codec: 9 ms: 20 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:3548 Starting timer [soft] 160 bytes per 20ms 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: START SESSION INITIALIZATION. sID=62. 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: ZID=306130303032393164366363. 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: Loading User's profile: 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: allowclear: OFF 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: autosecure: ON 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: disclose_bit: OFF 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: signal. role: Unknown 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: TTL: 4294967295 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: SAS schemes: 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 B256 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 B32 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: Ciphers: 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 AES3 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 AES1 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: PK schemes: 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 EC25 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 DH3k 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 DH2k 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 Mult 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: ATL: 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 HS32 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: Hashes: 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 S256 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: Session initialization - DONE. sID=62. 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: ATTACH NEW STREAM to sID=62: 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp]: Stream ID=0 UNKNOWN switching <NONE> ---> <ACTIVE>. 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: Empty slot was found - initializing new stream with ID=62. 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: Preparing ZRTP Hello according to the Session profile. 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp main]: ATTACH NEW STREAM - DONE. 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp engine]: START STREAM ID=62 mode=CLEAR state=ACTIVE. 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp]: Stream ID=62 CLEAR switching <ACTIVE> ---> <START>. 2015-03-10 12:37:38.755785 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16177 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:38.755785 [DEBUG] switch_core_media.c:5439 Set 2833 dtmf send payload to 101 2015-03-10 12:37:38.755785 [DEBUG] switch_core_media.c:5445 Set 2833 dtmf receive payload to 101 2015-03-10 12:37:38.755785 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1001(a)freeswitch.xyz.com.au! 2015-03-10 12:37:38.755785 [DEBUG] switch_channel.c:3399 (sofia/internal/1001(a)freeswitch.xyz.com.au) Callstate Change RINGING -> EARLY 2015-03-10 12:37:38.755785 [DEBUG] mod_sofia.c:780 Local SDP sofia/internal/1001(a)freeswitch.xyz.com.au: v=0 o=FreeSWITCH 1425930696 1425930697 IN IP4 10.0.2.145 s=FreeSWITCH c=IN IP4 10.0.2.145 t=0 0 m=audio 20762 RTP/AVP 9 101 a=rtpmap:9 G722/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv 2015-03-10 12:37:38.755785 [DEBUG] switch_core_session.c:908 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:38.755785 [NOTICE] switch_ivr_originate.c:3522 Channel [sofia/internal/1001(a)freeswitch.xyz.com.au] has been answered 2015-03-10 12:37:38.755785 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:38.755785 [DEBUG] switch_channel.c:3689 (sofia/internal/1001(a)freeswitch.xyz.com.au) Callstate Change EARLY -> ACTIVE 2015-03-10 12:37:38.755785 [DEBUG] sofia.c:6614 Channel sofia/internal/1001(a)freeswitch.xyz.com.au entering state [completed][200] 2015-03-10 12:37:38.755785 [DEBUG] switch_ivr_originate.c:3580 Originate Resulted in Success: [sofia/external/775] 2015-03-10 12:37:38.755785 [DEBUG] switch_core_session.c:908 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:38.755785 [DEBUG] switch_core_session.c:908 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:38.755785 [DEBUG] switch_ivr_bridge.c:1465 (sofia/external/775) State Change CS_CONSUME_MEDIA -> CS_EXCHANGE_MEDIA 2015-03-10 12:37:38.755785 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:38.755785 [DEBUG] switch_core_state_machine.c:472 (sofia/external/775) Running State Change CS_EXCHANGE_MEDIA 2015-03-10 12:37:38.755785 [DEBUG] switch_core_state_machine.c:538 (sofia/external/775) State EXCHANGE_MEDIA 2015-03-10 12:37:38.755785 [DEBUG] mod_sofia.c:594 SOFIA EXCHANGE_MEDIA 2015-03-10 12:37:38.795788 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:38.795788 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:38.795788 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:38.795788 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6663 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:38.815813 [DEBUG] sofia.c:6614 Channel sofia/internal/1001(a)freeswitch.xyz.com.au entering state [ready][200] 2015-03-10 12:37:38.815813 [DEBUG] switch_core_session.c:970 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:38.815813 [DEBUG] switch_core_session.c:970 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:38.815813 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16178 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:38.835797 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:38.835797 [DEBUG] sofia.c:6614 Channel sofia/internal/1001(a)freeswitch.xyz.com.au entering state [calling][0] 2015-03-10 12:37:38.895793 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6664 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:38.915789 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16179 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:38.935794 [DEBUG] switch_rtp.c:5853 Correct ip/port confirmed. 2015-03-10 12:37:38.935794 [NOTICE] switch_core_io.c:1261 Activating write resampler 2015-03-10 12:37:38.935794 [INFO] mod_com_g729.c:126 ENCODER LICENSE ALLOCATED--->0x7fc5640abbf0 0x7fc5640abbf0 2015-03-10 12:37:38.935794 [INFO] mod_com_g729.c:133 ENCODER CREATED------------->0x7fc5640abbf0 0x7fc5640abbf0 2015-03-10 12:37:38.935794 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:38.935794 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:38.935794 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:38.955811 [DEBUG] sofia.c:6614 Channel sofia/internal/1001(a)freeswitch.xyz.com.au entering state [ready][200] 2015-03-10 12:37:38.955811 [DEBUG] sofia.c:6624 Remote SDP: v=0 o=- 20183 20184 IN IP4 10.0.2.129 s=SDP data c=IN IP4 10.0.2.129 t=0 0 a=sendrecv m=audio 11794 RTP/AVP 9 101 a=rtpmap:9 G722/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:20 2015-03-10 12:37:38.955811 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [G722:9:8000:20:64000:1]/[G722:9:8000:20:64000:1] 2015-03-10 12:37:38.955811 [DEBUG] switch_core_media.c:3682 Audio Codec Compare [G722:9:8000:20:64000:1] ++++ is saved as a match 2015-03-10 12:37:38.955811 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMU:0:8000:20:64000:1] 2015-03-10 12:37:38.955811 [DEBUG] switch_core_media.c:3627 Audio Codec Compare [G722:9:8000:20:64000:1]/[PCMA:8:8000:20:64000:1] 2015-03-10 12:37:38.955811 [DEBUG] switch_core_media.c:3543 Set telephone-event payload to 101 2015-03-10 12:37:38.955811 [DEBUG] switch_core_media.c:3890 Set 2833 dtmf send/recv payload to 101 2015-03-10 12:37:38.955811 [DEBUG] sofia.c:7318 Processing updated SDP 2015-03-10 12:37:38.955811 [DEBUG] switch_core_media.c:5124 Audio params are unchanged for sofia/internal/1001(a)freeswitch.xyz.com.au. 2015-03-10 12:37:39.095797 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6665 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:39.115795 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16180 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:39.295792 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6666 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:39.315799 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16181 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:39.495820 [DEBUG] switch_rtp.c:1357 [ zrtp engine]: WARNING! HELLO have been resent 5 times without a response. Raising ZRTP_EVENT_NO_ZRTP_QUICK event. ID=61 2015-03-10 12:37:39.495820 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6667 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:39.515800 [DEBUG] switch_rtp.c:1357 [ zrtp engine]: WARNING! HELLO have been resent 5 times without a response. Raising ZRTP_EVENT_NO_ZRTP_QUICK event. ID=62 2015-03-10 12:37:39.515800 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16182 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:39.635793 [DEBUG] switch_rtp.c:5853 Correct ip/port confirmed. 2015-03-10 12:37:39.635793 [INFO] mod_com_g729.c:164 DECODER LICENSE ALLOCATED--->0x7fc5640abb70 0x7fc5640abb78 2015-03-10 12:37:39.635793 [INFO] mod_com_g729.c:171 DECODER CREATED------------->0x7fc5640abb70 0x7fc5640abb78 2015-03-10 12:37:39.635793 [NOTICE] switch_core_io.c:1261 Activating write resampler 2015-03-10 12:37:39.695794 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6668 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:39.715818 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16183 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:39.895794 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6669 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:39.915788 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16184 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:40.095795 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6670 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:40.115797 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16185 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:40.295795 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6671 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:40.315799 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16186 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:40.495794 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6672 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:40.515796 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16187 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:40.695794 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6673 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:40.715793 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16188 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:40.895795 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6674 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:40.915814 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16189 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:41.095793 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6675 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:41.115793 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16190 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:41.295810 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6676 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:41.315792 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16191 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:41.495802 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6677 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:41.515827 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16192 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:41.695792 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6678 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:41.715791 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16193 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:41.895794 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6679 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:41.915786 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16194 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:42.095794 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6680 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:42.115792 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16195 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:42.295796 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=2970911498 seq=6681 size=144. Stream 61:CLEAR:START 2015-03-10 12:37:42.315793 [DEBUG] switch_rtp.c:1357 [ zrtp utils]: Send <HELLO> ssrc=1447443834 seq=16196 size=144. Stream 62:CLEAR:START 2015-03-10 12:37:42.495796 [DEBUG] switch_rtp.c:1357 [ zrtp engine]: WARNING! HELLO Max retransmissions count reached (20 retries). ID=61 2015-03-10 12:37:42.495796 [DEBUG] switch_rtp.c:1357 [ zrtp]: Stream ID=61 CLEAR switching <START> ---> <NOZRTP>. 2015-03-10 12:37:42.515800 [DEBUG] switch_rtp.c:1357 [ zrtp engine]: WARNING! HELLO Max retransmissions count reached (20 retries). ID=62 2015-03-10 12:37:42.515800 [DEBUG] switch_rtp.c:1357 [ zrtp]: Stream ID=62 CLEAR switching <START> ---> <NOZRTP>. 2015-03-10 12:37:43.675790 [DEBUG] switch_core_session.c:1053 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:43.695793 [NOTICE] sofia.c:952 Hangup sofia/internal/1001(a)freeswitch.xyz.com.au [CS_EXECUTE] [NORMAL_CLEARING] 2015-03-10 12:37:43.695793 [DEBUG] switch_channel.c:3222 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [KILL] 2015-03-10 12:37:43.695793 [DEBUG] switch_core_session.c:1388 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:43.695793 [DEBUG] switch_ivr_bridge.c:660 BRIDGE THREAD DONE [sofia/internal/1001(a)freeswitch.xyz.com.au] 2015-03-10 12:37:43.695793 [DEBUG] switch_ivr_bridge.c:690 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:43.715797 [DEBUG] switch_ivr_bridge.c:579 sofia/internal/1001(a)freeswitch.xyz.com.au ending bridge by request from write function 2015-03-10 12:37:43.715797 [DEBUG] switch_ivr_bridge.c:660 BRIDGE THREAD DONE [sofia/external/775] 2015-03-10 12:37:43.715797 [DEBUG] switch_ivr_bridge.c:690 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:43.715797 [NOTICE] switch_ivr_bridge.c:754 Hangup sofia/external/775 [CS_EXCHANGE_MEDIA] [NORMAL_CLEARING] 2015-03-10 12:37:43.715797 [DEBUG] switch_channel.c:3222 Send signal sofia/external/775 [KILL] 2015-03-10 12:37:43.715797 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:538 (sofia/external/775) State EXCHANGE_MEDIA going to sleep 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:472 (sofia/external/775) Running State Change CS_HANGUP 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:735 (sofia/external/775) Callstate Change ACTIVE -> HANGUP 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:737 (sofia/external/775) State HANGUP 2015-03-10 12:37:43.715797 [DEBUG] mod_sofia.c:407 sofia/external/775 Overriding SIP cause 480 with 200 from the other leg 2015-03-10 12:37:43.715797 [DEBUG] mod_sofia.c:413 Channel sofia/external/775 hanging up, cause: NORMAL_CLEARING 2015-03-10 12:37:43.715797 [DEBUG] mod_sofia.c:465 Sending BYE to sofia/external/775 2015-03-10 12:37:43.715797 [DEBUG] switch_ivr_bridge.c:1563 sofia/external/775 skip receive message [UNBRIDGE] (channel is hungup already) 2015-03-10 12:37:43.715797 [DEBUG] switch_ivr_bridge.c:1566 sofia/internal/1001(a)freeswitch.xyz.com.au skip receive message [UNBRIDGE] (channel is hungup already) 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:60 sofia/external/775 Standard HANGUP, cause: NORMAL_CLEARING 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:737 (sofia/external/775) State HANGUP going to sleep 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:504 (sofia/external/775) State Change CS_HANGUP -> CS_REPORTING 2015-03-10 12:37:43.715797 [DEBUG] switch_core_session.c:2893 sofia/internal/1001(a)freeswitch.xyz.com.au skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already) 2015-03-10 12:37:43.715797 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:472 (sofia/external/775) Running State Change CS_REPORTING 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:535 (sofia/internal/1001(a)freeswitch.xyz.com.au) State EXECUTE going to sleep 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1001(a)freeswitch.xyz.com.au) Running State Change CS_HANGUP 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:823 (sofia/external/775) State REPORTING 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:104 sofia/external/775 Standard REPORTING, cause: NORMAL_CLEARING 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:823 (sofia/external/775) State REPORTING going to sleep 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:735 (sofia/internal/1001(a)freeswitch.xyz.com.au) Callstate Change ACTIVE -> HANGUP 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/1001(a)freeswitch.xyz.com.au) State HANGUP 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:498 (sofia/external/775) State Change CS_REPORTING -> CS_DESTROY 2015-03-10 12:37:43.715797 [DEBUG] switch_core_session.c:1388 Send signal sofia/external/775 [BREAK] 2015-03-10 12:37:43.715797 [DEBUG] switch_core_session.c:1615 Session 66 (sofia/external/775) Locked, Waiting on external entities 2015-03-10 12:37:43.715797 [NOTICE] switch_core_session.c:1633 Session 66 (sofia/external/775) Ended 2015-03-10 12:37:43.715797 [NOTICE] switch_core_session.c:1637 Close Channel sofia/external/775 [CS_DESTROY] 2015-03-10 12:37:43.715797 [DEBUG] mod_sofia.c:413 Channel sofia/internal/1001(a)freeswitch.xyz.com.au hanging up, cause: NORMAL_CLEARING 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:626 (sofia/external/775) Running State Change CS_DESTROY 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:636 (sofia/external/775) State DESTROY 2015-03-10 12:37:43.715797 [DEBUG] mod_sofia.c:323 sofia/external/775 SOFIA DESTROY 2015-03-10 12:37:43.715797 [INFO] mod_com_g729.c:95 DECODER DESTROYED----------->0x7fc5640abb70 0x7fc5640abb78 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:60 sofia/internal/1001(a)freeswitch.xyz.com.au Standard HANGUP, cause: NORMAL_CLEARING 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:737 (sofia/internal/1001(a)freeswitch.xyz.com.au) State HANGUP going to sleep 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:504 (sofia/internal/1001(a)freeswitch.xyz.com.au) State Change CS_HANGUP -> CS_REPORTING 2015-03-10 12:37:43.715797 [DEBUG] switch_core_session.c:1388 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:472 (sofia/internal/1001(a)freeswitch.xyz.com.au) Running State Change CS_REPORTING 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/1001(a)freeswitch.xyz.com.au) State REPORTING 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:104 sofia/internal/1001(a)freeswitch.xyz.com.au Standard REPORTING, cause: NORMAL_CLEARING 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:823 (sofia/internal/1001(a)freeswitch.xyz.com.au) State REPORTING going to sleep 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:498 (sofia/internal/1001(a)freeswitch.xyz.com.au) State Change CS_REPORTING -> CS_DESTROY 2015-03-10 12:37:43.715797 [DEBUG] switch_core_session.c:1388 Send signal sofia/internal/1001(a)freeswitch.xyz.com.au [BREAK] 2015-03-10 12:37:43.715797 [DEBUG] switch_core_session.c:1615 Session 65 (sofia/internal/1001(a)freeswitch.xyz.com.au) Locked, Waiting on external entities 2015-03-10 12:37:43.715797 [NOTICE] switch_core_session.c:1633 Session 65 (sofia/internal/1001(a)freeswitch.xyz.com.au) Ended 2015-03-10 12:37:43.715797 [NOTICE] switch_core_session.c:1637 Close Channel sofia/internal/1001(a)freeswitch.xyz.com.au [CS_DESTROY] 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:626 (sofia/internal/1001(a)freeswitch.xyz.com.au) Running State Change CS_DESTROY 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/1001(a)freeswitch.xyz.com.au) State DESTROY 2015-03-10 12:37:43.715797 [DEBUG] mod_sofia.c:323 sofia/internal/1001(a)freeswitch.xyz.com.au SOFIA DESTROY 2015-03-10 12:37:43.715797 [DEBUG] switch_rtp.c:1357 [ zrtp engine]: STOP STREAM ID=62 mode=CLEAR state=NOZRTP. 2015-03-10 12:37:43.715797 [DEBUG] switch_rtp.c:1357 [ zrtp]: Stream ID=0 UNKNOWN switching <NONE> ---> <NONE>. 2015-03-10 12:37:43.715797 [DEBUG] switch_rtp.c:1357 [ zrtp engine]: STOP STREAM ID=0 mode=UNKNOWN state=NONE. 2015-03-10 12:37:43.715797 [DEBUG] switch_rtp.c:1357 [ zrtp engine]: STOP STREAM ID=0 mode=UNKNOWN state=NONE. 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:111 sofia/internal/1001(a)freeswitch.xyz.com.au Standard DESTROY 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:636 (sofia/internal/1001(a)freeswitch.xyz.com.au) State DESTROY going to sleep 2015-03-10 12:37:43.715797 [INFO] mod_com_g729.c:98 DECODER LICENSE DEALLOCATED->0x7fc5640abb70 0x7fc5640abb78 2015-03-10 12:37:43.715797 [INFO] mod_com_g729.c:84 ENCODER DESTROYED----------->0x7fc5640abbf0 0x7fc5640abbf0 2015-03-10 12:37:43.715797 [INFO] mod_com_g729.c:87 ENCODER LICENSE DEALLOCATED->0x7fc5640abbf0 0x7fc5640abbf0 2015-03-10 12:37:43.715797 [DEBUG] switch_rtp.c:1357 [ zrtp engine]: STOP STREAM ID=61 mode=CLEAR state=NOZRTP. 2015-03-10 12:37:43.715797 [DEBUG] switch_rtp.c:1357 [ zrtp]: Stream ID=0 UNKNOWN switching <NONE> ---> <NONE>. 2015-03-10 12:37:43.715797 [DEBUG] switch_rtp.c:1357 [ zrtp engine]: STOP STREAM ID=0 mode=UNKNOWN state=NONE. 2015-03-10 12:37:43.715797 [DEBUG] switch_rtp.c:1357 [ zrtp engine]: STOP STREAM ID=0 mode=UNKNOWN state=NONE. 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:111 sofia/external/775 Standard DESTROY 2015-03-10 12:37:43.715797 [DEBUG] switch_core_state_machine.c:636 (sofia/external/775) State DESTROY going to sleep -- Jason Lewis http://emacstragic.net

2 2

Re: [Freeswitch-users] Outbound call status and conference_auto_outcall
by Sharath Kumar 10 Mar '15

10 Mar '15

Thank you Brian!. I will test it and let you know. -Sharath From: freeswitch-users-bounces(a)lists.freeswitch.org [mailto:freeswitch-users-bounces@lists.freeswitch.org] On Behalf Of Brian West Sent: Tuesday, March 10, 2015 4:53 PM To: FreeSWITCH Users Help Subject: Re: [Freeswitch-users] Outbound call status and conference_auto_outcall set the execute_on_hangup to a lua script to give you this possibly, or the api_hangup_hook ... just off the top of my head that is.. would need testing. On Tue, Mar 10, 2015 at 2:44 PM, Sharath Kumar <Sharath.Kumar(a)mezocliq.com<mailto:Sharath.Kumar@mezocliq.com>> wrote: Hello all, I am using “conference_auto_outcall” to dial a bunch of extensions. It works great. However, I need to know the status of whether the calls were answered or rejected ? Is there any way I can know this from the dialplan ? or is there any api that I can call from the dialplan ? Also, I am aware there is some sort of presence module but these phones are webrtc based and don’t yet really support any presence standards. I looked around for a solution to this and couldn’t find a solution. I appreciate if anyone can point me in the right direction. Thanks, Sharath _________________________________________________________________________ Professional FreeSWITCH Consulting Services: consulting(a)freeswitch.org<mailto:consulting@freeswitch.org> http://www.freeswitchsolutions.com Official FreeSWITCH Sites http://www.freeswitch.org http://confluence.freeswitch.org http://www.cluecon.com FreeSWITCH-users mailing list FreeSWITCH-users(a)lists.freeswitch.org<mailto:FreeSWITCH-users@lists.freeswitch.org> http://lists.freeswitch.org/mailman/listinfo/freeswitch-users UNSUBSCRIBE:http://lists.freeswitch.org/mailman/options/freeswitch-users http://www.freeswitch.org -- Brian West brian(a)freeswitch.org<mailto:brian@freeswitch.org> [Image removed by sender.] Twitter: @FreeSWITCH , @briankwest http://www.freeswitchbook.com http://www.freeswitchcookbook.com T:+19184209001 | F:+19184209002 | M:+1918424WEST (9378) iNUM:+883 5100 1420 9001 | ISN:410*543 | Skype:briankwest

1 0