March 2012 - FreeSWITCH-users - FreeSWITCH Mailing Lists

connexion attempts behing a firewall (wtf?)
by Bzzz 12 Mar '12

12 Mar '12

Hi, I just setup an FS svr w/ fusionpbx (only ext.+users created), and I found THAT in the FS log: 2012-03-11 16:51:30.795812 [DEBUG] sofia.c:7567 IP 72.55.156.56 Rejected by acl "domains". Falling back to Digest auth. 2012-03-11 16:51:30.795812 [WARNING] sofia_reg.c:1422 SIP auth challenge (INVITE) on sofia profile 'internal' for [88775950945170(a)86.68.18.226] from ip 72.55.156.56 2012-03-11 16:51:31.115813 [DEBUG] sofia.c:7567 IP 72.55.156.56 Rejected by acl "domains". Falling back to Digest auth. 2012-03-11 16:51:31.115813 [WARNING] sofia_reg.c:1422 SIP auth challenge (INVITE) on sofia profile 'internal' for [011441212790583(a)86.68.18.226] from ip 72.55.156.56 2012-03-11 16:51:31.985813 [DEBUG] sofia.c:7567 IP 72.55.156.56 Rejected by acl "domains". Falling back to Digest auth. 2012-03-11 16:51:31.985813 [WARNING] sofia_reg.c:1422 SIP auth challenge (INVITE) on sofia profile 'internal' for [00441212790587(a)86.68.18.226] from ip 72.55.156.56 2012-03-11 16:51:33.015828 [DEBUG] sofia.c:7567 IP 72.55.156.56 Rejected by acl "domains". Falling back to Digest auth. 2012-03-11 16:51:33.015828 [WARNING] sofia_reg.c:1422 SIP auth challenge (INVITE) on sofia profile 'internal' for [000441212790581(a)86.68.18.226] from ip 72.55.156.56 How can this freak reach my svr as I'm in my LAN and my modem box integrates a firewall. Oook (but not): just checked my box and found that there are 4 uPNP new rules: 0 UDP 5060 192.168.1.25 5060 1 TCP 5060 192.168.1.25 5060 2 UDP 5080 192.168.1.25 5080 3 TCP 5080 192.168.1.25 5080 I understand FS is opening these ports to be reached by external subscribers, but where can I stop it to do so until I made my internal tests, change these ports and limited VoIP to TLS only? JY -- masturbation, n.: Coming unscrewed.

3 4

fs + fusionpbx registered but not
by Bzzz 11 Mar '12

11 Mar '12

Hi list, I'm trying to use FS w/ fusionpbx: users & extensions created. My 2 softphones says they're successfully registered, fusionpbx says that too, but when I'm trying to make a call between them (whatever direction), FS log says: 2012-03-11 15:59:18.925845 [DEBUG] switch_event.c:1522 Parsing variable [sip_invite_domain]=[192.168.1.25] 2012-03-11 15:59:18.925845 [DEBUG] switch_event.c:1522 Parsing variable [presence_id]=[jy sur anubis(a)192.168.1.25] 2012-03-11 15:59:18.925845 [NOTICE] switch_ivr_originate.c:2459 Cannot create outgoing channel of type [error] cause: [USER_NOT_REGISTERED] 2012-03-11 15:59:18.925845 [DEBUG] switch_ivr_originate.c:3364 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED] 2012-03-11 15:59:18.925845 [NOTICE] switch_ivr_originate.c:2459 Cannot create outgoing channel of type [user] cause: [USER_NOT_REGISTERED] 2012-03-11 15:59:18.925845 [DEBUG] switch_ivr_originate.c:3364 Originate Resulted in Error Cause: 606 [USER_NOT_REGISTERED] 2012-03-11 15:59:18.925845 [INFO] mod_dptools.c:2922 Originate Failed. Cause: USER_NOT_REGISTERED Where am I wrong? JY -- The Supreme Court does it with all deliberate speed.

1 0

How to get and store values from mysql database to Lua script
by virendra bhati 11 Mar '12

11 Mar '12

Hi List, Below is my code by which I have connected Lua and mysql DB and displayed into FreeSwitch CLI. local dbh = freeswitch.Dbh("Billing","Billing","Tzru9unbcfuW6PV") if assert(dbh:connected()) == true then freeswitch.consoleLog("info", "connected"); assert(dbh:query("SELECT id, profile_name FROM sofia_conf", function(row) for key, val in pairs(row) do row[key] = val -- freeswitch.consoleLog("info", " row.id"); -- freeswitch.consoleLog("info", " profile_name"); freeswitch.consoleLog("info", "row[key]"); -- freeswitch.consoleLog("info", " profile_name"); end end)) -- stream:write(string.format("%5s : %s\n", row.id, row.profile_name)) -- end) else freeswitch.consoleLog("info", "not connected"); end How to get and store values from mysql database to Lua variables ? -- Thanks and regards Virendra Bhati +91-8885268942 Software Engineer E-mail-: virbhati(a)gmail.com Skype id:- virbhati2 Hyderabad(India)

2 1

Transferring calls from analog extension
by Shane Harrison 11 Mar '12

11 Mar '12

Spent most of th day trying to get an attended transfer working on an analog extension. Ideally I would like a 2 -way call to be "transfered" when the user hangs up ie. incoming call answered by analog extension (a-leg?), hookflash, dial 3rd party (b-leg?), talk to them and hang up to bridge a-leg and b-leg. However I couldn't find any hints on how to do this. What I did find is information on using att_txfer application in the dialplan as setup in the standard features.xml. This all works OK, I push *4 on the analog extension, the a-leg gets MOH, analog extension gets the played dialtone but pushing keys on the analog extension to enter the new destination does nothing. It appears as if DTMF is ignored. Analog extension users FreeTDM. Has context as default in freetdm.conf. Any pointers appreciated. Below is the console debug. It starts after the call is setup from a SIP (308) extension to the analog extension freetdm/2:1. 2012-03-11 19:38:50.393576 [DEBUG] ftdm_io.c:3530 [s2c1][1:4] Queuing DTMF * (debug = 0) 2012-03-11 19:38:50.393576 [DEBUG] mod_freetdm.c:799 Queuing DTMF [*] in channel FreeTDM/2:1/ device 2:1 2012-03-11 19:38:50.393576 [DEBUG] switch_ivr_bridge.c:391 Send signal sofia/internal/308(a)192.168.7.49 [BREAK] 2012-03-11 19:38:51.073573 [DEBUG] ftdm_io.c:3530 [s2c1][1:4] Queuing DTMF 4 (debug = 0) 2012-03-11 19:38:51.073573 [DEBUG] mod_freetdm.c:799 Queuing DTMF [4] in channel FreeTDM/2:1/ device 2:1 2012-03-11 19:38:51.073573 [DEBUG] switch_ivr_async.c:3058 sofia/internal/ 308(a)192.168.7.49 Processing meta digit '4' [execute_extension::att_xfer XML features] 2012-03-11 19:38:51.073573 [DEBUG] switch_core_session.c:1014 Send signal FreeTDM/2:1/ [BREAK] 2012-03-11 19:38:51.073573 [DEBUG] switch_ivr_bridge.c:391 Send signal sofia/internal/308(a)192.168.7.49 [BREAK] 2012-03-11 19:38:51.093575 [DEBUG] switch_core_session.c:731 Send signal FreeTDM/2:1/ [BREAK] 2012-03-11 19:38:51.173589 [DEBUG] switch_core_session.c:1014 Send signal sofia/internal/308(a)192.168.7.49 [BREAK] 2012-03-11 19:38:51.193585 [DEBUG] switch_core_session.c:731 Send signal sofia/internal/308(a)192.168.7.49 [BREAK] 2012-03-11 19:38:51.373573 [DEBUG] switch_ivr.c:591 sofia/internal/ 308(a)192.168.7.49 Command Execute playback(local_stream://moh) EXECUTE sofia/internal/308(a)192.168.7.49 playback(local_stream://moh) 2012-03-11 19:38:51.373573 [DEBUG] mod_local_stream.c:421 Opening Stream [moh/8000] 8000hz 2012-03-11 19:38:51.373573 [DEBUG] switch_ivr_play_say.c:1306 Codec Activated L16@8000hz 1 channels 20ms 2012-03-11 19:38:51.373573 [DEBUG] switch_ivr.c:591 FreeTDM/2:1/ Command Execute execute_extension(att_xfer XML features) EXECUTE FreeTDM/2:1/ execute_extension(att_xfer XML features) 2012-03-11 19:38:51.373573 [INFO] mod_dialplan_xml.c:485 Processing Shane PC <308>->att_xfer in context features Dialplan: FreeTDM/2:1/ parsing [features->dx] continue=false Dialplan: FreeTDM/2:1/ Regex (FAIL) [dx] destination_number(att_xfer) =~ /^dx$/ break=on-false Dialplan: FreeTDM/2:1/ parsing [features->att_xfer] continue=false Dialplan: FreeTDM/2:1/ Regex (PASS) [att_xfer] destination_number(att_xfer) =~ /^att_xfer$/ break=on-false Dialplan: FreeTDM/2:1/ Action read(3 4 'tone_stream://%(10000,0,350,440)' digits 30000 #) Dialplan: FreeTDM/2:1/ Action set(origination_cancel_key=#) Dialplan: FreeTDM/2:1/ Action att_xfer(user/${digits}(a)xxxx.xxx.nz) 2012-03-11 19:38:51.373573 [NOTICE] switch_core_session.c:2386 Execute read(3 4 'tone_stream://%(10000,0,350,440)' digits 30000 #) EXECUTE FreeTDM/2:1/ read(3 4 'tone_stream://%(10000,0,350,440)' digits 30000 #) 2012-03-11 19:38:51.373573 [DEBUG] switch_ivr_play_say.c:1306 Codec Activated L16@8000hz 1 channels 20ms 2012-03-11 19:39:01.410613 [DEBUG] switch_ivr_play_say.c:1678 done playing file tone_stream://%(10000,0,350,440)

1 0

Event Socket Library on different client machine
by guru singh 11 Mar '12

11 Mar '12

Hi, How can I move the ESL lib to different client machines (where FS is not installed) ? I ran 'make pymod' in libs/esl. On this machine I can go into python prompt and 'import ESL' without a problem I then moved ESL.py and ESL.pyc to the virtualenv of my python project on a different machine (venv/python2.7/site-packages) On this box, import ESL fails. The ESL wiki page says that it has no dependencies on freeswitch and can be moved around. What am I doing wrong? Thanks guru

2 4

git freeswitch cysco 504g and sipnet.ru unable to call gateway
by Lubimov Alexey 10 Mar '12

10 Mar '12

any ideas, why freeswitch send bye after 501 Not Implemented from spa 504G? recv 491 bytes from udp/[192.168.26.20]:5061 at 23:20:09.663308: ------------------------------------------------------------------------ SUBSCRIBE sip:10@sip.comp-house.ru SIP/2.0 Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-77d49247 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=e45937ca160bbb95 To: "avlubimov" <sip:10@sip.comp-house.ru> Call-ID: 3034efae-325ec501(a)192.168.26.20 CSeq: 49907 SUBSCRIBE Max-Forwards: 70 Contact: "avlubimov" <sip:10@192.168.26.20:5061> Expires: 15 Event: line-seize User-Agent: Cisco/SPA504G-7.4.8a Call-Info: <sip:sip.comp-house.ru>;appearance-index=1 Content-Length: 0 ------------------------------------------------------------------------ send 733 bytes to udp/[192.168.26.20]:5061 at 23:20:09.665718: ------------------------------------------------------------------------ SIP/2.0 202 Accepted Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-77d49247 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=e45937ca160bbb95 To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=tguJ7zPUrCJ5 Call-ID: 3034efae-325ec501(a)192.168.26.20 CSeq: 49907 SUBSCRIBE Contact: <sip:10@85.30.248.51:5060> Expires: 15 User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, precondition, path, replaces Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Subscription-State: active;expires=15 Content-Length: 0 ------------------------------------------------------------------------ send 850 bytes to udp/[192.168.26.20]:5061 at 23:20:09.666191: ------------------------------------------------------------------------ NOTIFY sip:10@192.168.26.20:5061 SIP/2.0 Via: SIP/2.0/UDP 85.30.248.51;rport;branch=z9hG4bK9eB52ag7rNKtg Max-Forwards: 70 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=6KmvQg3e5gvgS To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=e45937ca160bbb95 Call-ID: 3034efae-325ec501(a)192.168.26.20 CSeq: 25374740 NOTIFY Contact: <sip:10@85.30.248.51:5060> Expires: 15 Call-Info: <sip:sip.comp-house.ru>;appearance-index=1 User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, precondition, path, replaces Event: line-seize Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Subscription-State: active;expires=15 Content-Length: 0 ------------------------------------------------------------------------ send 992 bytes to udp/[192.168.26.20]:5061 at 23:20:09.667243: ------------------------------------------------------------------------ NOTIFY sip:10@192.168.26.20:5061 SIP/2.0 Via: SIP/2.0/UDP 85.30.248.51;rport;branch=z9hG4bKar4X450apy9cc Route: <sip:192.168.26.20:5061>;transport=udp Max-Forwards: 70 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=eRwWYuXZc6fo To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=908912105ff8d4f8 Call-ID: 8acdc9f0-ea487e98(a)192.168.26.20 CSeq: 187271947 NOTIFY Contact: <sip:10@85.30.248.51:5060;transport=udp> Call-Info: <sip:comp-house.ru>;appearance-index=1;appearance-state=seized Call-Info: <sip:comp-house.ru>;appearance-index=*;appearance-state=idle User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, precondition, path, replaces Event: call-info Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Subscription-State: active;expires=3352 Content-Length: 0 ------------------------------------------------------------------------ recv 320 bytes from udp/[192.168.26.20]:5061 at 23:20:09.718698: ------------------------------------------------------------------------ SIP/2.0 200 OK To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=e45937ca160bbb95 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=6KmvQg3e5gvgS Call-ID: 3034efae-325ec501(a)192.168.26.20 CSeq: 25374740 NOTIFY Via: SIP/2.0/UDP 85.30.248.51;branch=z9hG4bK9eB52ag7rNKtg Server: Cisco/SPA504G-7.4.8a Content-Length: 0 ------------------------------------------------------------------------ recv 320 bytes from udp/[192.168.26.20]:5061 at 23:20:09.737243: ------------------------------------------------------------------------ SIP/2.0 200 OK To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=908912105ff8d4f8 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=eRwWYuXZc6fo Call-ID: 8acdc9f0-ea487e98(a)192.168.26.20 CSeq: 187271947 NOTIFY Via: SIP/2.0/UDP 85.30.248.51;branch=z9hG4bKar4X450apy9cc Server: Cisco/SPA504G-7.4.8a Content-Length: 0 ------------------------------------------------------------------------ recv 507 bytes from udp/[192.168.26.20]:5061 at 23:20:13.562633: ------------------------------------------------------------------------ SUBSCRIBE sip:10@85.30.248.51:5060 SIP/2.0 Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-3f015cc3 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=e45937ca160bbb95 To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=tguJ7zPUrCJ5 Call-ID: 3034efae-325ec501(a)192.168.26.20 CSeq: 49908 SUBSCRIBE Max-Forwards: 70 Contact: "avlubimov" <sip:10@192.168.26.20:5061> Expires: 0 Event: line-seize User-Agent: Cisco/SPA504G-7.4.8a Call-Info: <sip:sip.comp-house.ru>;appearance-index=1 Content-Length: 0 ------------------------------------------------------------------------ send 743 bytes to udp/[192.168.26.20]:5061 at 23:20:13.564567: ------------------------------------------------------------------------ SIP/2.0 202 Accepted Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-3f015cc3 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=e45937ca160bbb95 To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=tguJ7zPUrCJ5 Call-ID: 3034efae-325ec501(a)192.168.26.20 CSeq: 49908 SUBSCRIBE Contact: <sip:10@85.30.248.51:5060> Expires: 0 User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, precondition, path, replaces Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Subscription-State: terminated;reason=noresource Content-Length: 0 ------------------------------------------------------------------------ send 917 bytes to udp/[192.168.26.20]:5061 at 23:20:13.565467: ------------------------------------------------------------------------ NOTIFY sip:10@192.168.26.20:5061 SIP/2.0 Via: SIP/2.0/UDP 85.30.248.51;rport;branch=z9hG4bKB1Xp60HeK7ZZQ Route: <sip:192.168.26.20:5061>;transport=udp Max-Forwards: 70 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=eRwWYuXZc6fo To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=908912105ff8d4f8 Call-ID: 8acdc9f0-ea487e98(a)192.168.26.20 CSeq: 187271948 NOTIFY Contact: <sip:10@85.30.248.51:5060;transport=udp> Call-Info: <sip:comp-house.ru>;appearance-index=*;appearance-state=idle User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, precondition, path, replaces Event: call-info Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Subscription-State: active;expires=3348 Content-Length: 0 ------------------------------------------------------------------------ recv 320 bytes from udp/[192.168.26.20]:5061 at 23:20:13.601524: ------------------------------------------------------------------------ SIP/2.0 200 OK To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=908912105ff8d4f8 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=eRwWYuXZc6fo Call-ID: 8acdc9f0-ea487e98(a)192.168.26.20 CSeq: 187271948 NOTIFY Via: SIP/2.0/UDP 85.30.248.51;branch=z9hG4bKB1Xp60HeK7ZZQ Server: Cisco/SPA504G-7.4.8a Content-Length: 0 ------------------------------------------------------------------------ recv 490 bytes from udp/[192.168.26.20]:5061 at 23:20:15.178280: ------------------------------------------------------------------------ SUBSCRIBE sip:10@sip.comp-house.ru SIP/2.0 Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-6b39d1c From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=6517ea9082c439af To: "avlubimov" <sip:10@sip.comp-house.ru> Call-ID: 51e5d0e4-932d676b(a)192.168.26.20 CSeq: 46361 SUBSCRIBE Max-Forwards: 70 Contact: "avlubimov" <sip:10@192.168.26.20:5061> Expires: 15 Event: line-seize User-Agent: Cisco/SPA504G-7.4.8a Call-Info: <sip:sip.comp-house.ru>;appearance-index=1 Content-Length: 0 ------------------------------------------------------------------------ send 732 bytes to udp/[192.168.26.20]:5061 at 23:20:15.180173: ------------------------------------------------------------------------ SIP/2.0 202 Accepted Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-6b39d1c From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=6517ea9082c439af To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=UsgRjAPCH9cF Call-ID: 51e5d0e4-932d676b(a)192.168.26.20 CSeq: 46361 SUBSCRIBE Contact: <sip:10@85.30.248.51:5060> Expires: 15 User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, precondition, path, replaces Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Subscription-State: active;expires=15 Content-Length: 0 ------------------------------------------------------------------------ send 850 bytes to udp/[192.168.26.20]:5061 at 23:20:15.180411: ------------------------------------------------------------------------ NOTIFY sip:10@192.168.26.20:5061 SIP/2.0 Via: SIP/2.0/UDP 85.30.248.51;rport;branch=z9hG4bKcaQF8U2HggpjK Max-Forwards: 70 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=7vDNSBmj2Sj3m To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=6517ea9082c439af Call-ID: 51e5d0e4-932d676b(a)192.168.26.20 CSeq: 25374743 NOTIFY Contact: <sip:10@85.30.248.51:5060> Expires: 15 Call-Info: <sip:sip.comp-house.ru>;appearance-index=1 User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, precondition, path, replaces Event: line-seize Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Subscription-State: active;expires=15 Content-Length: 0 ------------------------------------------------------------------------ send 992 bytes to udp/[192.168.26.20]:5061 at 23:20:15.181545: ------------------------------------------------------------------------ NOTIFY sip:10@192.168.26.20:5061 SIP/2.0 Via: SIP/2.0/UDP 85.30.248.51;rport;branch=z9hG4bKDKg89pKNDSc5e Route: <sip:192.168.26.20:5061>;transport=udp Max-Forwards: 70 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=eRwWYuXZc6fo To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=908912105ff8d4f8 Call-ID: 8acdc9f0-ea487e98(a)192.168.26.20 CSeq: 187271949 NOTIFY Contact: <sip:10@85.30.248.51:5060;transport=udp> Call-Info: <sip:comp-house.ru>;appearance-index=1;appearance-state=seized Call-Info: <sip:comp-house.ru>;appearance-index=*;appearance-state=idle User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, precondition, path, replaces Event: call-info Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Subscription-State: active;expires=3346 Content-Length: 0 ------------------------------------------------------------------------ recv 320 bytes from udp/[192.168.26.20]:5061 at 23:20:15.237027: ------------------------------------------------------------------------ SIP/2.0 200 OK To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=6517ea9082c439af From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=7vDNSBmj2Sj3m Call-ID: 51e5d0e4-932d676b(a)192.168.26.20 CSeq: 25374743 NOTIFY Via: SIP/2.0/UDP 85.30.248.51;branch=z9hG4bKcaQF8U2HggpjK Server: Cisco/SPA504G-7.4.8a Content-Length: 0 ------------------------------------------------------------------------ recv 320 bytes from udp/[192.168.26.20]:5061 at 23:20:15.251656: ------------------------------------------------------------------------ SIP/2.0 200 OK To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=908912105ff8d4f8 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=eRwWYuXZc6fo Call-ID: 8acdc9f0-ea487e98(a)192.168.26.20 CSeq: 187271949 NOTIFY Via: SIP/2.0/UDP 85.30.248.51;branch=z9hG4bKDKg89pKNDSc5e Server: Cisco/SPA504G-7.4.8a Content-Length: 0 ------------------------------------------------------------------------ recv 855 bytes from udp/[192.168.26.20]:5061 at 23:20:17.554852: ------------------------------------------------------------------------ INVITE sip:89168030237@sip.comp-house.ru SIP/2.0 Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-207e455d From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=5697f670d4f0a03co1 To: <sip:89168030237@sip.comp-house.ru> Call-ID: a7634980-1f9ee86c(a)192.168.26.20 CSeq: 101 INVITE Max-Forwards: 70 Contact: "avlubimov" <sip:10@192.168.26.20:5061> Expires: 240 User-Agent: Cisco/SPA504G-7.4.8a Call-Info: <sip:sip.comp-house.ru>;appearance-index=1 Content-Length: 257 Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER, UPDATE Supported: replaces Content-Type: application/sdp v=0 o=- 29037 29037 IN IP4 192.168.26.20 s=- c=IN IP4 192.168.26.20 t=0 0 m=audio 16500 RTP/AVP 18 0 8 101 a=rtpmap:18 G729a/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:30 a=sendrecv ------------------------------------------------------------------------ send 320 bytes to udp/[192.168.26.20]:5061 at 23:20:17.555281: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-207e455d From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=5697f670d4f0a03co1 To: <sip:89168030237@sip.comp-house.ru> Call-ID: a7634980-1f9ee86c(a)192.168.26.20 CSeq: 101 INVITE User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Content-Length: 0 ------------------------------------------------------------------------ send 808 bytes to udp/[192.168.26.20]:5061 at 23:20:17.557294: ------------------------------------------------------------------------ SIP/2.0 407 Proxy Authentication Required Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-207e455d From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=5697f670d4f0a03co1 To: <sip:89168030237@sip.comp-house.ru>;tag=856DU64NZ28Ng Call-ID: a7634980-1f9ee86c(a)192.168.26.20 CSeq: 101 INVITE User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Accept: application/sdp Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, precondition, path, replaces Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Proxy-Authenticate: Digest realm="comp-house.ru", nonce="991c9820-6b07-11e1-b573-bdc32e505683", algorithm=MD5, qop="auth" Content-Length: 0 ------------------------------------------------------------------------ recv 471 bytes from udp/[192.168.26.20]:5061 at 23:20:17.583006: ------------------------------------------------------------------------ ACK sip:89168030237@sip.comp-house.ru SIP/2.0 Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-207e455d From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=5697f670d4f0a03co1 To: <sip:89168030237@sip.comp-house.ru>;tag=856DU64NZ28Ng Call-ID: a7634980-1f9ee86c(a)192.168.26.20 CSeq: 101 ACK Max-Forwards: 70 Contact: "avlubimov" <sip:10@192.168.26.20:5061> User-Agent: Cisco/SPA504G-7.4.8a Call-Info: <sip:sip.comp-house.ru>;appearance-index=1 Content-Length: 0 ------------------------------------------------------------------------ recv 1102 bytes from udp/[192.168.26.20]:5061 at 23:20:17.588436: ------------------------------------------------------------------------ INVITE sip:89168030237@sip.comp-house.ru SIP/2.0 Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-c30ceb25 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=5697f670d4f0a03co1 To: <sip:89168030237@sip.comp-house.ru> Call-ID: a7634980-1f9ee86c(a)192.168.26.20 CSeq: 102 INVITE Max-Forwards: 70 Proxy-Authorization: Digest username="10",realm="comp-house.ru",nonce="991c9820-6b07-11e1-b573-bdc32e505683",uri="sip:89168030237@sip.comp-house.ru",algorithm=MD5,response="1a4163060aa44faacdd2f674ffb7f13b",qop=auth,nc=00000001,cnonce="526a5637" Contact: "avlubimov" <sip:10@192.168.26.20:5061> Expires: 240 User-Agent: Cisco/SPA504G-7.4.8a Call-Info: <sip:sip.comp-house.ru>;appearance-index=1 Content-Length: 257 Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER, UPDATE Supported: replaces Content-Type: application/sdp v=0 o=- 29037 29037 IN IP4 192.168.26.20 s=- c=IN IP4 192.168.26.20 t=0 0 m=audio 16500 RTP/AVP 18 0 8 101 a=rtpmap:18 G729a/8000 a=rtpmap:0 PCMU/8000 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-15 a=ptime:30 a=sendrecv ------------------------------------------------------------------------ send 320 bytes to udp/[192.168.26.20]:5061 at 23:20:17.588834: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-c30ceb25 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=5697f670d4f0a03co1 To: <sip:89168030237@sip.comp-house.ru> Call-ID: a7634980-1f9ee86c(a)192.168.26.20 CSeq: 102 INVITE User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Content-Length: 0 ------------------------------------------------------------------------ send 885 bytes to udp/[192.168.26.20]:5061 at 23:20:21.262101: ------------------------------------------------------------------------ SIP/2.0 180 Ringing Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-c30ceb25 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=5697f670d4f0a03co1 To: <sip:89168030237@sip.comp-house.ru>;tag=9e06v1NSvBZ8B Call-ID: a7634980-1f9ee86c(a)192.168.26.20 CSeq: 102 INVITE Contact: <sip:89168030237@85.30.248.51:5060;transport=udp> Call-Info: <sip:sip.comp-house.ru>;appearance-index=1 User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Accept: application/sdp Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, precondition, path, replaces Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Content-Length: 0 Remote-Party-ID: "Outbound Call" <sip:+79168030237@sip.comp-house.ru>;party=calling;privacy=off;screen=no ------------------------------------------------------------------------ send 1089 bytes to udp/[192.168.26.20]:5061 at 23:20:27.649934: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-c30ceb25 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=5697f670d4f0a03co1 To: <sip:89168030237@sip.comp-house.ru>;tag=9e06v1NSvBZ8B Call-ID: a7634980-1f9ee86c(a)192.168.26.20 CSeq: 102 INVITE Contact: <sip:89168030237@85.30.248.51:5060;transport=udp> Call-Info: <sip:sip.comp-house.ru>;appearance-index=1 User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, precondition, path, replaces Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Content-Type: application/sdp Content-Disposition: session Content-Length: 171 Remote-Party-ID: "Outbound Call" <sip:+79168030237@sip.comp-house.ru>;party=calling;privacy=off;screen=no v=0 o=FreeSWITCH 1610198872 1610198873 IN IP4 85.30.248.51 s=FreeSWITCH c=IN IP4 85.30.248.51 t=0 0 m=audio 0 RTP/AVP 96 a=rtpmap:96 G729/8000 a=fmtp:96 annexb=no ------------------------------------------------------------------------ recv 732 bytes from udp/[192.168.26.20]:5061 at 23:20:27.679656: ------------------------------------------------------------------------ ACK sip:89168030237@85.30.248.51:5060;transport=udp SIP/2.0 Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-d832aefe From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=5697f670d4f0a03co1 To: <sip:89168030237@sip.comp-house.ru>;tag=9e06v1NSvBZ8B Call-ID: a7634980-1f9ee86c(a)192.168.26.20 CSeq: 102 ACK Max-Forwards: 70 Proxy-Authorization: Digest username="10",realm="comp-house.ru",nonce="991c9820-6b07-11e1-b573-bdc32e505683",uri="sip:89168030237@sip.comp-house.ru",algorithm=MD5,response="1a4163060aa44faacdd2f674ffb7f13b",qop=auth,nc=00000001,cnonce="526a5637" Contact: "avlubimov" <sip:10@192.168.26.20:5061> User-Agent: Cisco/SPA504G-7.4.8a Call-Info: <sip:sip.comp-house.ru>;appearance-index=1 Content-Length: 0 ------------------------------------------------------------------------ send 909 bytes to udp/[192.168.26.20]:5061 at 23:20:27.681881: ------------------------------------------------------------------------ UPDATE sip:10@192.168.26.20:5061 SIP/2.0 Via: SIP/2.0/UDP 85.30.248.51;rport;branch=z9hG4bKev90Bj4ra22Qa Max-Forwards: 70 From: <sip:89168030237@sip.comp-house.ru>;tag=9e06v1NSvBZ8B To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=5697f670d4f0a03co1 Call-ID: a7634980-1f9ee86c(a)192.168.26.20 CSeq: 25374749 UPDATE Contact: <sip:89168030237@85.30.248.51:5060;transport=udp> User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, precondition, path, replaces Content-Type: application/sdp Content-Disposition: session Content-Length: 171 P-Asserted-Identity: "Outbound Call" <sip:+79168030237@85.30.248.51> v=0 o=FreeSWITCH 1610198872 1610198873 IN IP4 85.30.248.51 s=FreeSWITCH c=IN IP4 85.30.248.51 t=0 0 m=audio 0 RTP/AVP 96 a=rtpmap:96 G729/8000 a=fmtp:96 annexb=no ------------------------------------------------------------------------ recv 506 bytes from udp/[192.168.26.20]:5061 at 23:20:27.686466: ------------------------------------------------------------------------ SUBSCRIBE sip:10@85.30.248.51:5060 SIP/2.0 Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-e8394fc From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=6517ea9082c439af To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=UsgRjAPCH9cF Call-ID: 51e5d0e4-932d676b(a)192.168.26.20 CSeq: 46362 SUBSCRIBE Max-Forwards: 70 Contact: "avlubimov" <sip:10@192.168.26.20:5061> Expires: 0 Event: line-seize User-Agent: Cisco/SPA504G-7.4.8a Call-Info: <sip:sip.comp-house.ru>;appearance-index=1 Content-Length: 0 ------------------------------------------------------------------------ send 742 bytes to udp/[192.168.26.20]:5061 at 23:20:27.688327: ------------------------------------------------------------------------ SIP/2.0 202 Accepted Via: SIP/2.0/UDP 192.168.26.20:5061;branch=z9hG4bK-e8394fc From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=6517ea9082c439af To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=UsgRjAPCH9cF Call-ID: 51e5d0e4-932d676b(a)192.168.26.20 CSeq: 46362 SUBSCRIBE Contact: <sip:10@85.30.248.51:5060> Expires: 0 User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, precondition, path, replaces Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Subscription-State: terminated;reason=noresource Content-Length: 0 ------------------------------------------------------------------------ send 917 bytes to udp/[192.168.26.20]:5061 at 23:20:27.689850: ------------------------------------------------------------------------ NOTIFY sip:10@192.168.26.20:5061 SIP/2.0 Via: SIP/2.0/UDP 85.30.248.51;rport;branch=z9hG4bKF52SDDNv7aSap Route: <sip:192.168.26.20:5061>;transport=udp Max-Forwards: 70 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=eRwWYuXZc6fo To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=908912105ff8d4f8 Call-ID: 8acdc9f0-ea487e98(a)192.168.26.20 CSeq: 187271950 NOTIFY Contact: <sip:10@85.30.248.51:5060;transport=udp> Call-Info: <sip:comp-house.ru>;appearance-index=*;appearance-state=idle User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, precondition, path, replaces Event: call-info Allow-Events: talk, hold, presence, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer Subscription-State: active;expires=3334 Content-Length: 0 ------------------------------------------------------------------------ recv 332 bytes from udp/[192.168.26.20]:5061 at 23:20:27.714474: ------------------------------------------------------------------------ SIP/2.0 501 Not Implemented To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=5697f670d4f0a03co1 From: <sip:89168030237@sip.comp-house.ru>;tag=9e06v1NSvBZ8B Call-ID: a7634980-1f9ee86c(a)192.168.26.20 CSeq: 25374749 UPDATE Via: SIP/2.0/UDP 85.30.248.51;branch=z9hG4bKev90Bj4ra22Qa Server: Cisco/SPA504G-7.4.8a Content-Length: 0 ------------------------------------------------------------------------ send 599 bytes to udp/[192.168.26.20]:5061 at 23:20:27.715049: ------------------------------------------------------------------------ BYE sip:10@192.168.26.20:5061 SIP/2.0 Via: SIP/2.0/UDP 85.30.248.51;rport;branch=z9hG4bKgevjF85Z4KFXH Max-Forwards: 70 From: <sip:89168030237@sip.comp-house.ru>;tag=9e06v1NSvBZ8B To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=5697f670d4f0a03co1 Call-ID: a7634980-1f9ee86c(a)192.168.26.20 CSeq: 25374750 BYE Contact: <sip:89168030237@85.30.248.51:5060;transport=udp> User-Agent: FreeSWITCH-mod_sofia/1.0.head-git- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, UPDATE, INFO, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE Supported: timer, precondition, path, replaces Content-Length: 0 ------------------------------------------------------------------------ recv 320 bytes from udp/[192.168.26.20]:5061 at 23:20:27.731308: ------------------------------------------------------------------------ SIP/2.0 200 OK To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=908912105ff8d4f8 From: "avlubimov" <sip:10@sip.comp-house.ru>;tag=eRwWYuXZc6fo Call-ID: 8acdc9f0-ea487e98(a)192.168.26.20 CSeq: 187271950 NOTIFY Via: SIP/2.0/UDP 85.30.248.51;branch=z9hG4bKF52SDDNv7aSap Server: Cisco/SPA504G-7.4.8a Content-Length: 0 ------------------------------------------------------------------------ recv 332 bytes from udp/[192.168.26.20]:5061 at 23:20:27.736262: ------------------------------------------------------------------------ SIP/2.0 405 Method Not Allowed To: "avlubimov" <sip:10@sip.comp-house.ru>;tag=5697f670d4f0a03co1 From: <sip:89168030237@sip.comp-house.ru>;tag=9e06v1NSvBZ8B Call-ID: a7634980-1f9ee86c(a)192.168.26.20 CSeq: 25374750 BYE Via: SIP/2.0/UDP 85.30.248.51;branch=z9hG4bKgevjF85Z4KFXH Server: Cisco/SPA504G-7.4.8a Content-Length: 0 ------------------------------------------------------------------------

1 0

execution ends after lcr command
by adam harris 10 Mar '12

10 Mar '12

>From my esl application after executing lcr command, the freeswitch log says the last command has exectuted and the call is ended by hanging up The poision point where the lcr command is run in my application is not the last command, why does freeswitch think it has and hang up the call?

2 1

Getting SIP verbose message
by Jimmy Godbout 10 Mar '12

10 Mar '12

Hi, Is it possible to get the phrase associated with a SIP code in a variable ? If I receive an error saying "insufficient funds", is it possible to retrieve it inside a variable in FS ? Thanks, Sipster ____________________________________________________________ GET FREE SMILEYS FOR YOUR IM & EMAIL - Learn more at http://www.inbox.com/smileys Works with AIM®, MSN® Messenger, Yahoo!® Messenger, ICQ®, Google Talk™ and most webmails

2 1

reloading mod_java crashes freeswitch is it normal?
by babak yakhchali 10 Mar '12

10 Mar '12

Hi Recently I was trying to use mod_java and it is working fine, but whenever I issue reload mod_java command freeswitch crashes. Is it normal?. I'm using jre 1.7 u2. thanx

2 1

Unable to call cisco from freeswitch/blubox
by Robbie A. Garrett 10 Mar '12

10 Mar '12

Hi All, My home use lab uses cisco call manager 8.0. My old setup was cisco call manager to asterisk and then to google voice. Since asterisk and google voice are now broken; I'm looking to move in the direction of free switch. Currently My cisco call manager can call any extension on free switch and leave voicemail's. When I add google talk to frees witch I'm able to call from my cisco VoIP phone, through free switch, and to google. My issue is that free switch is unable to call my cisco call manager. Below is an output of the log of a call from extension 2002 to extension 4000. From what I can tell is that free-switch is not even trying to talk to 10.0.1.99 (my call manger). It's failing before it gets that far. 2012-03-09 08:05:13.418262 [DEBUG] sofia_glue.c:4353 Audio Codec Compare [PCMU:0:8000:0:64000]/[G7221:115:32000:20:48000] 2012-03-09 08:05:13.418262 [DEBUG] sofia_glue.c:4353 Audio Codec Compare [PCMU:0:8000:0:64000]/[G7221:107:16000:20:32000] 2012-03-09 08:05:13.418262 [DEBUG] sofia_glue.c:4353 Audio Codec Compare [PCMU:0:8000:0:64000]/[G722:9:8000:20:64000] 2012-03-09 08:05:13.418262 [DEBUG] sofia_glue.c:4353 Audio Codec Compare [PCMU:0:8000:0:64000]/[PCMU:0:8000:20:64000] 2012-03-09 08:05:13.418262 [DEBUG] sofia_glue.c:2721 Set Codec sofia/sipinterface_1/peter_gibbons@bluebox PCMU/8000 20 ms 160 samples 64000 bits 2012-03-09 08:05:13.418262 [DEBUG] sofia_glue.c:4457 Set 2833 dtmf send/recv payload to 101 2012-03-09 08:05:13.418262 [DEBUG] sofia.c:4732 (sofia/sipinterface_1/peter_gibbons@bluebox) State Change CS_NEW -> CS_INIT 2012-03-09 08:05:13.418262 [DEBUG] switch_core_session.c:1057 Send signal sofia/sipinterface_1/peter_gibbons@bluebox [BREAK] 2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:318 (sofia/sipinterface_1/peter_gibbons@bluebox) Running State Change CS_INIT 2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:342 (sofia/sipinterface_1/peter_gibbons@bluebox) State INIT 2012-03-09 08:05:13.419735 [DEBUG] mod_sofia.c:83 sofia/sipinterface_1/peter_gibbons@bluebox SOFIA INIT 2012-03-09 08:05:13.419735 [DEBUG] mod_sofia.c:123 (sofia/sipinterface_1/peter_gibbons@bluebox) State Change CS_INIT -> CS_ROUTING 2012-03-09 08:05:13.419735 [DEBUG] switch_core_session.c:1057 Send signal sofia/sipinterface_1/peter_gibbons@bluebox [BREAK] 2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:342 (sofia/sipinterface_1/peter_gibbons@bluebox) State INIT going to sleep 2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:318 (sofia/sipinterface_1/peter_gibbons@bluebox) Running State Change CS_ROUTING 2012-03-09 08:05:13.419735 [DEBUG] switch_channel.c:1615 (sofia/sipinterface_1/peter_gibbons@bluebox) Callstate Change DOWN -> RINGING 2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:345 (sofia/sipinterface_1/peter_gibbons@bluebox) State ROUTING 2012-03-09 08:05:13.419735 [DEBUG] mod_sofia.c:146 sofia/sipinterface_1/peter_gibbons@bluebox SOFIA ROUTING 2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:77 sofia/sipinterface_1/peter_gibbons@bluebox Standard ROUTING 2012-03-09 08:05:13.419735 [INFO] mod_dialplan_xml.c:331 Processing peter_gibbons <peter_gibbons>->4000 in context context_1 Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->conditioning_callerid] continue=true Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (PASS) [conditioning_callerid] ${internal_caller_id_number}(2002) =~ /^.+$/ break=on-false Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action set(effective_caller_id_name=${internal_caller_id_name}) Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action set(effective_caller_id_number=${internal_caller_id_number}) Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->postroute_global] continue=true Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Absolute Condition [postroute_global] Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action hash(insert/${domain_name}-spymap/${caller_id_number}/${uuid}) Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action hash(insert/${domain_name}-last_dial/${caller_id_number}/${destination_number}) Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action hash(insert/${domain_name}-last_dial/global/${uuid}) Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action set(RFC2822_DATE=${strftime(%a, %d %b %Y %T %z)}) Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->preanswer_gtalk] continue=true Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (FAIL) [preanswer_gtalk] source(mod_sofia) =~ /^mod_dingaling$/ break=on-false Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->main_trunk_1_pattern_5] continue=true Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (PASS) [main_trunk_1_pattern_5] destination_number(4000) =~ /^(40[0-9]{2})$/ break=on-false Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action set(prepend=) Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (PASS) [main_trunk_1_pattern_5] ${outbound_caller_id_number}(5555552002) =~ /^.+$/ break=never Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action set(effective_caller_id_name=${outbound_caller_id_name}) Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action set(effective_caller_id_number=${outbound_caller_id_number}) Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action export(sip_cid_type=rpid) Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (PASS) [main_trunk_1_pattern_5] destination_number(4000) =~ /^(40[0-9]{2})$/ break=on-false Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action set(failure_causes=NORMAL_CLEARING,ORIGINATOR_CANCEL,CRASH) Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Action bridge(sofia/gateway/trunk_1/${prepend}4000) Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->main_number_6] continue=true Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (FAIL) [main_number_6] destination_number(4000) =~ /^2006$/ break=on-false Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->main_number_5] continue=true Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (FAIL) [main_number_5] destination_number(4000) =~ /^2005$/ break=on-false Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->main_number_4] continue=true Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (FAIL) [main_number_4] destination_number(4000) =~ /^2004$/ break=on-false Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->main_number_3] continue=true Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (FAIL) [main_number_3] destination_number(4000) =~ /^2003$/ break=on-false Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->main_number_2] continue=true Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (FAIL) [main_number_2] destination_number(4000) =~ /^2002$/ break=on-false Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox parsing [context_1->main_number_1] continue=true Dialplan: sofia/sipinterface_1/peter_gibbons@bluebox Regex (FAIL) [main_number_1] destination_number(4000) =~ /^2001$/ break=on-false 2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:119 (sofia/sipinterface_1/peter_gibbons@bluebox) State Change CS_ROUTING -> CS_EXECUTE 2012-03-09 08:05:13.419735 [DEBUG] switch_core_session.c:1057 Send signal sofia/sipinterface_1/peter_gibbons@bluebox [BREAK] 2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:345 (sofia/sipinterface_1/peter_gibbons@bluebox) State ROUTING going to sleep 2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:318 (sofia/sipinterface_1/peter_gibbons@bluebox) Running State Change CS_EXECUTE 2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:352 (sofia/sipinterface_1/peter_gibbons@bluebox) State EXECUTE 2012-03-09 08:05:13.419735 [DEBUG] mod_sofia.c:239 sofia/sipinterface_1/peter_gibbons@bluebox SOFIA EXECUTE 2012-03-09 08:05:13.419735 [DEBUG] switch_core_state_machine.c:157 sofia/sipinterface_1/peter_gibbons@bluebox Standard EXECUTE EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox set(effective_caller_id_name=Peter Gibbons) 2012-03-09 08:05:13.419735 [DEBUG] mod_dptools.c:1028 sofia/sipinterface_1/peter_gibbons@bluebox SET [effective_caller_id_name]=[Peter Gibbons] EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox set(effective_caller_id_number=2002) 2012-03-09 08:05:13.419735 [DEBUG] mod_dptools.c:1028 sofia/sipinterface_1/peter_gibbons@bluebox SET [effective_caller_id_number]=[2002] EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox hash(insert/10.0.1.3-spymap/peter_gibbons/bc1115e3-b592-454c-8813-a6a7fb2754d4) EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox hash(insert/10.0.1.3-last_dial/peter_gibbons/4000) EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox hash(insert/10.0.1.3-last_dial/global/bc1115e3-b592-454c-8813-a6a7fb2754d4) EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox set(RFC2822_DATE=Fri, 09 Mar 2012 08:05:13 -0800) 2012-03-09 08:05:13.421692 [DEBUG] mod_dptools.c:1028 sofia/sipinterface_1/peter_gibbons@bluebox SET [RFC2822_DATE]=[Fri, 09 Mar 2012 08:05:13 -0800] EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox set(prepend=) 2012-03-09 08:05:13.421692 [DEBUG] mod_dptools.c:1028 sofia/sipinterface_1/peter_gibbons@bluebox SET [prepend]=[UNDEF] EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox set(effective_caller_id_name=Peter Gibbons) 2012-03-09 08:05:13.421692 [DEBUG] mod_dptools.c:1028 sofia/sipinterface_1/peter_gibbons@bluebox SET [effective_caller_id_name]=[Peter Gibbons] EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox set(effective_caller_id_number=5555552002) 2012-03-09 08:05:13.421692 [DEBUG] mod_dptools.c:1028 sofia/sipinterface_1/peter_gibbons@bluebox SET [effective_caller_id_number]=[5555552002] EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox export(sip_cid_type=rpid) 2012-03-09 08:05:13.421692 [DEBUG] switch_channel.c:933 EXPORT (export_vars) [sip_cid_type]=[rpid] EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox set(failure_causes=NORMAL_CLEARING,ORIGINATOR_CANCEL,CRASH) 2012-03-09 08:05:13.421692 [DEBUG] mod_dptools.c:1028 sofia/sipinterface_1/peter_gibbons@bluebox SET [failure_causes]=[NORMAL_CLEARING,ORIGINATOR_CANCEL,CRASH] EXECUTE sofia/sipinterface_1/peter_gibbons@bluebox bridge(sofia/gateway/trunk_1/4000) 2012-03-09 08:05:13.421692 [DEBUG] switch_channel.c:890 sofia/sipinterface_1/peter_gibbons@bluebox EXPORTING[export_vars] [sip_cid_type]=[rpid] to event 2012-03-09 08:05:13.421692 [ERR] mod_sofia.c:3738 Invalid Gateway 2012-03-09 08:05:13.421692 [NOTICE] mod_sofia.c:4060 Close Channel N/A [CS_NEW] 2012-03-09 08:05:13.421692 [DEBUG] switch_core_state_machine.c:434 () Running State Change CS_DESTROY 2012-03-09 08:05:13.421692 [DEBUG] switch_core_state_machine.c:444 (N/A) State DESTROY 2012-03-09 08:05:13.421692 [DEBUG] mod_sofia.c:361 N/A SOFIA DESTROY 2012-03-09 08:05:13.421692 [DEBUG] switch_core_state_machine.c:444 (N/A) State DESTROY going to sleep 2012-03-09 08:05:13.421692 [ERR] switch_ivr_originate.c:2605 Cannot create outgoing channel of type [sofia] cause: [INVALID_NUMBER_FORMAT] 2012-03-09 08:05:13.421692 [DEBUG] switch_ivr_originate.c:3413 Originate Resulted in Error Cause: 28 [INVALID_NUMBER_FORMAT] 2012-03-09 08:05:13.421692 [INFO] mod_dptools.c:2579 Originate Failed. Cause: INVALID_NUMBER_FORMAT 2012-03-09 08:05:13.421692 [DEBUG] mod_dptools.c:2610 Failure causes [NORMAL_CLEARING,ORIGINATOR_CANCEL,CRASH]: Cause: INVALID_NUMBER_FORMAT 2012-03-09 08:05:13.421692 [NOTICE] switch_core_state_machine.c:189 sofia/sipinterface_1/peter_gibbons@bluebox has executed the last dialplan instruction, hanging up. 2012-03-09 08:05:13.421692 [DEBUG] switch_channel.c:2457 (sofia/sipinterface_1/peter_gibbons@bluebox) Callstate Change RINGING -> HANGUP 2012-03-09 08:05:13.421692 [NOTICE] switch_core_state_machine.c:191 Hangup sofia/sipinterface_1/peter_gibbons@bluebox [CS_EXECUTE] [NORMAL_CLEARING] 2012-03-09 08:05:13.421692 [DEBUG] switch_channel.c:2473 Send signal sofia/sipinterface_1/peter_gibbons@bluebox [KILL] 2012-03-09 08:05:13.421692 [DEBUG] switch_core_session.c:1057 Send signal sofia/sipinterface_1/peter_gibbons@bluebox [BREAK] 2012-03-09 08:05:13.421692 [DEBUG] switch_core_state_machine.c:352 (sofia/sipinterface_1/peter_gibbons@bluebox) State EXECUTE going to sleep 2012-03-09 08:05:13.421692 [DEBUG] switch_core_state_machine.c:318 (sofia/sipinterface_1/peter_gibbons@bluebox) Running State Change CS_HANGUP 2012-03-09 08:05:13.423711 [DEBUG] switch_core_state_machine.c:539 (sofia/sipinterface_1/peter_gibbons@bluebox) State HANGUP 2012-03-09 08:05:13.423711 [DEBUG] mod_sofia.c:456 Channel sofia/sipinterface_1/peter_gibbons@bluebox hanging up, cause: NORMAL_CLEARING 2012-03-09 08:05:13.427318 [DEBUG] mod_sofia.c:518 Responding to INVITE with: 480 2012-03-09 08:05:13.427318 [DEBUG] switch_core_state_machine.c:46 sofia/sipinterface_1/peter_gibbons@bluebox Standard HANGUP, cause: NORMAL_CLEARING 2012-03-09 08:05:13.427318 [DEBUG] switch_core_state_machine.c:539 (sofia/sipinterface_1/peter_gibbons@bluebox) State HANGUP going to sleep 2012-03-09 08:05:13.427318 [DEBUG] switch_core_state_machine.c:337 (sofia/sipinterface_1/peter_gibbons@bluebox) State Change CS_HANGUP -> CS_REPORTING 2012-03-09 08:05:13.427318 [DEBUG] switch_core_session.c:1057 Send signal sofia/sipinterface_1/peter_gibbons@bluebox [BREAK] 2012-03-09 08:05:13.427318 [DEBUG] switch_core_state_machine.c:318 (sofia/sipinterface_1/peter_gibbons@bluebox) Running State Change CS_REPORTING 2012-03-09 08:05:13.427318 [DEBUG] switch_core_state_machine.c:599 (sofia/sipinterface_1/peter_gibbons@bluebox) State REPORTING 2012-03-09 08:05:13.586710 [DEBUG] switch_core_state_machine.c:53 sofia/sipinterface_1/peter_gibbons@bluebox Standard REPORTING, cause: NORMAL_CLEARING 2012-03-09 08:05:13.586710 [DEBUG] switch_core_state_machine.c:599 (sofia/sipinterface_1/peter_gibbons@bluebox) State REPORTING going to sleep 2012-03-09 08:05:13.586710 [DEBUG] switch_core_state_machine.c:331 (sofia/sipinterface_1/peter_gibbons@bluebox) State Change CS_REPORTING -> CS_DESTROY 2012-03-09 08:05:13.586710 [DEBUG] switch_core_session.c:1057 Send signal sofia/sipinterface_1/peter_gibbons@bluebox [BREAK] 2012-03-09 08:05:13.586710 [DEBUG] switch_core_session.c:1224 Session 66 (sofia/sipinterface_1/peter_gibbons@bluebox) Locked, Waiting on external entities 2012-03-09 08:05:13.586710 [NOTICE] switch_core_session.c:1242 Session 66 (sofia/sipinterface_1/peter_gibbons@bluebox) Ended 2012-03-09 08:05:13.586710 [NOTICE] switch_core_session.c:1244 Close Channel sofia/sipinterface_1/peter_gibbons@bluebox [CS_DESTROY] 2012-03-09 08:05:13.588724 [DEBUG] switch_core_state_machine.c:431 (sofia/sipinterface_1/peter_gibbons@bluebox) Callstate Change HANGUP -> DOWN 2012-03-09 08:05:13.588724 [DEBUG] switch_core_state_machine.c:434 (sofia/sipinterface_1/peter_gibbons@bluebox) Running State Change CS_DESTROY 2012-03-09 08:05:13.588724 [DEBUG] switch_core_state_machine.c:444 (sofia/sipinterface_1/peter_gibbons@bluebox) State DESTROY 2012-03-09 08:05:13.588724 [DEBUG] mod_sofia.c:361 sofia/sipinterface_1/peter_gibbons@bluebox SOFIA DESTROY 2012-03-09 08:05:13.588724 [DEBUG] switch_core_state_machine.c:60 sofia/sipinterface_1/peter_gibbons@bluebox Standard DESTROY 2012-03-09 08:05:13.588724 [DEBUG] switch_core_state_machine.c:444 (sofia/sipinterface_1/peter_gibbons@bluebox) State DESTROY going to sleep

2 2