- FreeSWITCH-users - FreeSWITCH Mailing Lists

Freetdm ss7 redundancy / failover
by Vallimamod Abdullah 07 Mar '14

07 Mar '14

Hi List, I have freeswitch on a server with a sangoma A104D card and ss7 lib, with 4 E1 links. All links carry ss7 signalling information and are grouped in 2 linksets. I would like to add some redundancy or failover with a 2nd identical server so that if the first one fails, I can do some kind of ’sofia recover’ and retrieve all ongoing calls. Or at least, reduce the downtime to a few seconds. I cannot just put each linkset on a separate server as the signalling information for a given call may arrive on any link set. For example, I can receive the call setup on a linkset and the release on another. Also, I cannot have 2 point codes with my telco, unfortunately. What do you guys use to solve this problem? Is there a way to forward a ss7 signalling message to another freeswitch or to have a passive listening mode one the backup server (with some kind of switch duplicating the E1 signal on both servers, or just Y cables...)? Thank you! - Vallimamod .

3 2

mod_xml_radius concurrency problem
by Ričardas Stoma 07 Mar '14

07 Mar '14

I'm using mod_xml_radius module to do radius authentication and accounting. When doing stress test (using sipp), i noticed that EVERY time when the number of concurrent calls reached exactly 245, authentications started to fail. >From the logs, i see these errors appearing after 245 calls: freeswitch: rc_send_server: no reply from RADIUS server localhost.localdomain:1812, 127.0.0.1 FreeSwitch and FreeRadius are communicating over localhost. I'm using 3 servers to do this stress test. First server generates calls, seconds server does freeswitch + freeradius stuff and third servers is used for terminating calls. Calls are generated with RTP stream. Wireshark shows that freeradius is sending correct responses to every mod_xml_radius request, but after 245 calls, responses do not reach destination (i see error messages "destination port is unreachable"). When the number of concurrent calls drops below 245, new calls are authenticated correctly (until it reaches that weird 245 limit). I'm using CentOS 6 (64 bit) Does anyone know why i'm getting this weird limitation? Is this related to freeswitch? freeradius server? mod_xml_radius? freeradius-client? linux?

3 2

Distorted sound with JsSIP WebRTC and latest freeswitch
by Jayesh Nambiar 07 Mar '14

07 Mar '14

Hi, I've been working on Freeswitch and WebRTC applications for quite some time. I was working on Freeswitch version *(git c811580 2013-09-06 00:55:50Z)* and the voice quality was always good with that version. Today I upgraded to the latest master version *(git f9f3699 2014-03-07 04:32:56Z 64bit)* and suddenly the sound that goes out of the WebRTC client is always distorted/choppy. I also tried with few versions which got committed in February but they also had choppy sound. The call scenario is as follows: Normal SIP Endpoint calls a WebRTC endpoint. I have enforced PCMU for the leg going towards WebRTC as I had read about some problems using OPUS codecwith freeswitch here https://code.google.com/p/webrtc/issues/detail?id=2768. My outgoing dial-string looks as below: {sip_invite_domain=${context},absolute_codec_string=PCMU,media_webrtc=true}sofia/ abc.com/${sip_req_uri} Sofia parameters are as follows: <param name="sip-trace" value="off"/> <param name="log-auth-failures" value="true"/> <param name="sip-ip" value="203.XXX.123.57"/> <param name="rtp-ip" value="203.XXX.123.57"/> <param name="sip-port" value="5000"/> <param name="context" value="abc.com"/> <param name="dtmf-type" value="rfc2833"/> <param name="rfc2833-pt" value="101"/> <param name="dtmf-duration" value="2000"/> <param name="caller-id-in-from" value="true"/> <param name="caller-id-type" value="pid"/> <param name="suppress-cng" value="true"/> <param name="inbound-codec-prefs" value="OPUS,G722,PCMU,PCMA"/> <param name="outbound-codec-prefs" value="PCMU,PCMA"/> <param name="rtp-timeout-sec" value="300"/> <param name="rtp-hold-timeout-sec" value="300"/> <param name="outbound-use-uuid-as-callid" value="true"/> I generally encountered such distorted quality with WebRTC when CN was advertised in SDP going towards JS-SIP. This is the reason I added suppress- sng as true in the profile. My outgoing SDP is as follows: v=0. o=FreeSWITCH 1394161698 1394161699 IN IP4 203.XXX.123.57. s=FreeSWITCH. c=IN IP4 203.XXX.123.57. t=0 0. a=msid-semantic: WMS lBMrtzG9kpA0bTRb2XqCeNEeEVGsBGsM. m=audio 17482 RTP/SAVPF 0 101. a=rtpmap:101 telephone-event/8000. a=fingerprint:sha-256 A2:DD:5A:FE:03:98:BB:59:A5:67:EE:D2:B1:DF:B9:E7:84:7C:D0:1D:C2:68:39:EF:60:E6:5B:48:E9:72:CB:5B. a=rtcp-mux. a=rtcp:17482 IN IP4 203.XXX.123.57. a=ssrc:2871096156 cname:744rtBqDQQuSAcTt. a=ssrc:2871096156 msid:lBMrtzG9kpA0bTRb2XqCeNEeEVGsBGsM a0. a=ssrc:2871096156 mslabel:lBMrtzG9kpA0bTRb2XqCeNEeEVGsBGsM. a=ssrc:2871096156 label:lBMrtzG9kpA0bTRb2XqCeNEeEVGsBGsMa0. a=ice-ufrag:09V4Nq9hcFADbSg9. a=ice-pwd:Maq6BHzioU0OWK7M. a=candidate:5046006301 1 udp 659136 203.XXX.123.57 17482 typ host generation0. a=candidate:5046006301 2 udp 659136 203.XXX.123.57 17482 typ host generation0. a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline: sV6KRgjWRIajcY4QqbNBQeUxxjh90KbdtfAwdmo2. a=silenceSupp:off - - - -. a=ptime:20. Is there anything that I can add or remove to fix this quality problem or any new channel variable related to webrtc that has been added but not documented anywhere. The sound going towards JS-SIP sounds acceptable butthe sound going outside JS-SIP is distorted. Any help here will be appreciated as this quality problem doesn't allow me to move to new versions and stay updated !! Thanks, --- Jayesh

2 1

i've problem with TLS
by dwi yulianto 07 Mar '14

07 Mar '14

i've folowed tutorial from http://wiki.freeswitch.org/wiki/SIP_TLS but when im use phonerlite as softphone i've problem when enable TLS in phonerlite, and when i see in FS_CLI from my freeswitch server i got this error tport_tls.c:869 tls_connect() tls_connect(0xb67215c8): events NEGOTIATING tport_tls.c:869 tls_connect() tls_connect(0xb67215c8): events NEGOTIATING tport_tls.c:958 tls_connect() tls_connect(0xb67215c8): TLS setup failed (error:00000001:lib(0):func(0):reason(1)) anyone know the solution from that error? thanks.

3 7

TLS with Yealink and Fanvil phones
by Yehavi Bourvine 07 Mar '14

07 Mar '14

Hello, As a part of a tender for IP phones I am testing TLS with various phones against FS v 1.2.17. SNOM and Poylcom works ok. Yealink did not, but they got enough debug information to create a fix. Fanvil claims that the SIPS packet generated by FS does not end with CRLFCRLF, thus they fail parsing it, and ask me to add this suffix. Who is right? FS or Fanvil? I can browse the sources and try to add this to see whether it helps, but I have no idea what it might break... Thanks, __Yehavi:

4 4

PlayAndGetDigits query
by Srini K 07 Mar '14

07 Mar '14

Hi, Iam using Mod_Managed to PlayAndGetDigits. It plays EnterZip.wav file and waits for 5 digit Zip code to be entered. No issues on succesful entry. On invalid entry (within the retry limits) it plays InvalidZip.wav followed by EnterZip.wav. Is it the expected behaviour ? On Invalid entry I want only InvalidZip.wav to be played NOT EnterZip.wav is there a way? My API call looks like digits = session.PlayAndGetDigits(5, 5, 3, 5000, "#*", "EnterZip.wav", "InvalidZip.wav", "\\d+", "", 3000, null) I referred the following wiki too. http://wiki.freeswitch.org/wiki/Misc._Dialplan_Tools_play_and_get_digits https://wiki.freeswitch.org/wiki/Mod_lua#session:playAndGetDigits Thanks Srini

1 0

Gateways Registration / Authentication
by mbo 07 Mar '14

07 Mar '14

I’ve set up a sip trunk between two freeswitches. On freeswitch A I’ve configured a gateway <gateway name="testgw2"> <param name="username" value="toni"/> <param name="password" value="toni456"/> <param name="proxy" value="192.168.1.135"/> <param name="register" value="true"/> <param name="caller-id-in-from" value="true"/> </gateway> on freeswitch B I’ve configured a user appropriate to the gateway <include> <user id="toni"> <params> <param name="password" value="toni456"/> <param name="vm-password" value="1000"/> </params> <variables> </variables> </user> </include> To call from freeswitch A to freeswitch B I've configured the following dialplan <extension name="test"> <condition field="destination_number" expression="^(12345)$"> <action application="bridge" data="user/toni"/> </condition> </extension> Now my question. However freeswitch A is registered to freeswitch B with the gateway user, I get a "Proxy Authentication Required" SIP message as response to an invite. This is because I have set the parameter „auth_calls" in the sip profile to true. Is there a way to configure the sip profile or gateway to accept calls only from this gateway? If I change the parameter „auth_calls“ to „false“, I do not get the "Proxy Authentication Required“ message, but then all calls received on this profile do not need authentication. Thanks Markus

2 1

Double DTMF digits
by Andy Ayers 07 Mar '14

07 Mar '14

Hi, I have an freeswitch system running which accepts incoming calls and requests a pincode for people to identify themselves to the system. I am getting an increasing number of issues where the dtmf tones being received appear to get doubled up. So I enter 1234 on my telephone keypad and 11223344 appears to be received in the buffer when calling getDigits. This doesn't happen all the time but often enough to be a problem. All the calls in to my system are forwarded on to me directly via SIP from a major UK telecoms provider that terminates numbers for us. Can anyone suggest what dtmf settings I may have got wrong that would cause this phenomenon or any suggestions how I can go about fixing it? I'm using . <action application="start_dtmf" /> In my dialplan. And these settings in my SIP profile: <param name="dtmf-duration" value="100"/> <param name="dtmf-type" value="rfc2833"/> Any help much appreciated. Many thanks Andy

3 4

How can I do a half-duplex (transmit only) eavesdrop on a call leg?
by D D 07 Mar '14

07 Mar '14

Hi, I tested the eavesdrop on a call leg, and it allowed me to hear both the transmit and receive data streams for the call leg. How can I eavesdrop on just the transmit side of a call leg? Thanks, David

1 0

Call waiting implementation in LUA
by Kevin Stewart 07 Mar '14

07 Mar '14

I have a problem that appears to be with uuid_bridge I have an lua event handler that is trying to control calls. on an incoming event "RECV_INFO" I would like to switch calls that the user is on (implement call waiting) I have 3 call legs. a b and c a an incoming call bridged to b b is an outgoing call bridged to a c anunanswered incomming call and is in ringing state. I want a to go on hold and b,c bridged what I get is B on holdA with silence and C still ringing. (the only sip packets sent are a reinvite to A to setting a=sendonly) I have the uuid ofcalls a b and c are stored in a_uuid b_uuid and c_uuid respectively my code looks like this: function logger(message) freeswitch.console_log("debug","callwaiting.lua:" .. message .."\n"); end local name = event:getHeader("Event-Name") if ( name == "RECV_INFO") then local api = freeswitch.API(); local sip_original_user = event:getHeader("SIP-From-User"); local b_uuid = event:getHeader("Caller-Unique-ID"); local a_uuid = event:getHeader("Other-Leg-Unique-ID"); local c_uuid = api:execute("hash","select/"..sip_original_user.."/4"); logger("a_uuid:"..a_uuid.."\n") logger("b_uuid:"..b_uuid.."\n") logger("c_uuid:"..c_uuid.."\n") api:execute("uuid_park", a_uuid); api:execute("uuid_park", b_uuid); api:execute("uuid_hold", a_uuid); api:execute("uuid_bridge", b_uuid .. " " .. c_uuid); end logs A invites in 2014-03-07 10:19:45.751614 [NOTICE] switch_channel.c:1055 New Channel sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061> [6ed900e4-2f0e-4a92-8b3e-f10c990d007a] invite out to B 2014-03-07 10:19:45.791753 [NOTICE] switch_channel.c:1055 New Channel sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> [67701a09-90d9-4b0e-a114-d7726ad8666b] incoming call from C 2014-03-07 10:19:58.871603 [NOTICE] switch_channel.c:1055 New Channel sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061> [ed3aabd0-9f2e-4b2d-a9c6-a468e9e2966e] logs report that the a_uid b_uuid and c_uuuid are the correct values. 2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:a_uuid:6ed900e4-2f0e-4a92-8b3e-f10c990d007a 2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:b_uuid:67701a09-90d9-4b0e-a114-d7726ad8666b 2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:c_uuid:ed3aabd0-9f2e-4b2d-a9c6-a468e9e2966e ---------------------------------------------------- freeswitch@internal> tport.c:2757 tport_wakeup_pri() tport_wakeup_pri(0x1eb4080): events IN tport.c:2872 tport_recv_event() tport_recv_event(0x1eb4080) tport.c:3213 tport_recv_iovec() tport_recv_iovec(0x1eb4080) msg 0x7ff1000346c0 from (udp/172.20.1.204:5066) has 511 bytes, veclen = 1 recv 511 bytes from udp/[10.15.1.2]:5060 at 21:40:15.032473: ------------------------------------------------------------------------ INFO sip:mod_sofia@172.20.1.204:5066<mailto:sip:mod_sofia@172.20.1.204:5066> SIP/2.0 Via: SIP/2.0/UDP 10.15.1.2:5060;branch=z9hG4bKsj7nji107oa0fl40r561.1 From: <sip:6492810587@10.15.1.2><mailto:sip:6492810587@10.15.1.2>;tag=SDu03v199-0082-0000017d-0558i0 To: "Anonymous" <sip:6499196120@172.20.1.204><mailto:sip:6499196120@172.20.1.204>;tag=UHmc2KHB3923D Call-ID: b4407d44-201a-1232-1f9d-000c2963be0e CSeq: 1 INFO Max-Forwards: 28 Contact: "6492810587" <sip:6492810587@10.15.1.2:5060;transport=udp><mailto:sip:6492810587@10.15.1.2:5060;transport=udp> Date: Thu, 06 Mar 2014 21:35:25 GMT Content-Type: application/broadsoft Content-Length: 17 event flashhook ------------------------------------------------------------------------ tport.c:3031 tport_deliver() tport_deliver(0x1eb4080): msg 0x7ff1000346c0 (511 bytes) from udp/10.15.1.2:5066/sip next=(nil) nta.c:2812 agent_recv_request() nta: received INFO sip:mod_sofia@172.20.1.204:5066<mailto:sip:mod_sofia@172.20.1.204:5066> SIP/2.0 (CSeq 1) nta.c:3171 agent_aliases() nta: canonizing sip:mod_sofia@172.20.1.204:5066<mailto:sip:mod_sofia@172.20.1.204:5066> with contact nta.c:2988 agent_recv_request() nta: INFO (1) going to existing leg nua_server.c:102 nua_stack_process_request() nua: nua_stack_process_request: entering nua_stack.c:271 nua_stack_event() nua(0x2006920): event i_info 100 Trying nua_stack.c:359 nua_application_event() nua: nua_application_event: entering 2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:1049 Send signal sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> [BREAK] nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering 2014-03-07 10:20:03.151602 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:a_uuid:6ed900e4-2f0e-4a92-8b3e-f10c990d007a 2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:b_uuid:67701a09-90d9-4b0e-a114-d7726ad8666b 2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:c_uuid:ed3aabd0-9f2e-4b2d-a9c6-a468e9e2966e 2014-03-07 10:20:03.151602 [DEBUG] switch_ivr.c:2891 (sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061>) State Change CS_EXECUTE -> CS_PARK 2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061> [BREAK] 2014-03-07 10:20:03.151602 [DEBUG] switch_ivr.c:2891 (sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2>) State Change CS_EXCHANGE_MEDIA -> CS_PARK 2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> [BREAK] 2014-03-07 10:20:03.151602 [DEBUG] switch_channel.c:1789 (sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061>) Callstate Change ACTIVE -> HELD 2014-03-07 10:20:03.151602 [DEBUG] sofia_glue.c:1225 sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061> sending invite version: 1.5.8b git bf9e3a1 2014-02-19 21:13:51Z 64bit Local SDP: v=0 o=FreeSWITCH 1394123290 1394123292 IN IP4 172.20.1.204 s=FreeSWITCH c=IN IP4 172.20.1.204 t=0 0 m=audio 17500 RTP/AVP 8 101 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=sendrecv nua.c:633 nua_invite() nua: nua_invite: entering nua_stack.c:529 nua_signal() nua(0x7ff100007ce0): sent signal r_invite 2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:904 Send signal sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061> [BREAK] 2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:1184 Send signal sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> [BREAK] 2014-03-07 10:20:03.151602 [INFO] switch_channel.c:3057 sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> Flipping CID from "Anonymous" <6499196120> to "Outbound Call" <6492810587> 2014-03-07 10:20:03.151602 [DEBUG] switch_ivr_bridge.c:1846 (sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2>) State Change CS_PARK -> CS_HIBERNATE 2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> [BREAK] 2014-03-07 10:20:03.151602 [DEBUG] switch_ivr_bridge.c:1848 (sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061>) State Change CS_PARK -> CS_HIBERNATE 2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061> [BREAK] nua_stack.c:569 nua_stack_signal() nua(0x7ff100007ce0): recv signal r_invite nua_params.c:480 nua_stack_set_params() nua: nua_stack_set_params: entering soa.c:405 soa_set_params() soa_set_params(static::0x7ff1000085e0, ...) called soa.c:1052 soa_set_user_sdp() soa_set_user_sdp(static::0x7ff1000085e0, (nil), 0x2039637, -1) called soa.c:1302 soa_init_offer_answer() soa_init_offer_answer(static::0x7ff1000085e0) called soa.c:1426 soa_generate_offer() soa_generate_offer(static::0x7ff1000085e0, 0) called soa_static.c:1137 offer_answer_step() soa_static_offer_answer_action(0x7ff1000085e0, soa_generate_offer): called soa_static.c:1196 offer_answer_step() soa_static(0x7ff1000085e0, soa_generate_offer): upgrade with local description soa_static.c:1020 soa_sdp_mode_set() soa_sdp_mode_set(0x7ff10e3a0a40, (nil), "*"): called soa_static.c:1020 soa_sdp_mode_set() soa_sdp_mode_set(0x7ff10e3a0a40, (nil), "*"): called soa_static.c:1425 offer_answer_step() soa_static(0x7ff1000085e0, soa_generate_offer): storing local description soa.c:1270 soa_get_local_sdp() soa_get_local_sdp(static::0x7ff1000085e0, [(nil)], [0x7ff10e3a2b68], [0x7ff10e3a2b64]) called nta.c:2663 nta_tpn_by_url() nta: selecting scheme sip tport.c:3265 tport_tsend() tport_tsend(0x1eb4080) tpn = */172.20.1.201:5061 tport.c:4054 tport_resolve() tport_resolve addrinfo = 172.20.1.201:5061 tport.c:4688 tport_by_addrinfo() tport_by_addrinfo(0x1eb4080): not found by name */172.20.1.201:5061 tport.c:3602 tport_vsend() tport_vsend(0x1eb4080): 961 bytes of 961 to udp/172.20.1.201:5061 tport.c:3500 tport_send_msg() tport_vsend returned 961 send 961 bytes to udp/[172.20.1.201]:5061 at 21:40:15.045585: ------------------------------------------------------------------------ INVITE sip:6499196120@172.20.1.201:5061<mailto:sip:6499196120@172.20.1.201:5061> SIP/2.0 Via: SIP/2.0/UDP 172.20.1.204:5066;rport;branch=z9hG4bKQ3Qym8BcyZU8K Max-Forwards: 69 From: <sip:6492810587@172.20.1.204:5066><mailto:sip:6492810587@172.20.1.204:5066>;tag=t8tK0r0750cHj To: "Anonymous" <sip:6499196120@172.20.1.201:5061><mailto:sip:6499196120@172.20.1.201:5061>;tag=as02ccecfe Call-ID: 419a7a7d150b4049389c91f1109676d4(a)172.20.1.201<mailto:419a7a7d150b4049389c91f1109676d4@172.20.1.201> CSeq: 56734943 INVITE Contact: <sip:6492810587@172.20.1.204:5066;transport=udp><mailto:sip:6492810587@172.20.1.204:5066;transport=udp> User-Agent: FreeSWITCH-mod_sofia/1.5.8b+git~20140219T211351Z~bf9e3a1f9e~64bit Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY Supported: timer, path, replaces Content-Type: application/sdp Content-Disposition: session Content-Length: 232 X-FS-Support: update_display,send_info v=0 o=FreeSWITCH 1394123290 1394123292 IN IP4 172.20.1.204 s=FreeSWITCH c=IN IP4 172.20.1.204 t=0 0 m=audio 17500 RTP/AVP 8 101 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=sendonly a=ptime:20 ------------------------------------------------------------------------ nta.c:8190 outgoing_send() nta: sent INVITE (56734943) to */172.20.1.201:5061 tport.c:4168 tport_pend() tport_pend(0x1eb4080): pending 0x7ff10004f7e0 for udp/172.20.1.204:5066 (already 0) nua_session.c:4143 signal_call_state_change() nua(0x7ff100007ce0): ready call updated: calling sent offer soa.c:1270 soa_get_local_sdp() soa_get_local_sdp(static::0x7ff1000085e0, [0x7ff10e3a2b58], [0x7ff10e3a2b60], [(nil)]) called nua_stack.c:269 nua_stack_event() nua(0x7ff100007ce0): event i_state INVITE sent 2014-03-07 10:20:03.151602 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:API uuid: nua_stack.c:359 nua_application_event() nua: nua_application_event: entering 2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:1049 Send signal sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061> [BREAK] tport.c:2757 tport_wakeup_pri() tport_wakeup_pri(0x1eb4080): events IN tport.c:2872 tport_recv_event() tport_recv_event(0x1eb4080) tport.c:3213 tport_recv_iovec() tport_recv_iovec(0x1eb4080) msg 0x7ff100055140 from (udp/172.20.1.204:5066) has 515 bytes, veclen = 1 recv 515 bytes from udp/[172.20.1.201]:5061 at 21:40:15.046966: ------------------------------------------------------------------------ SIP/2.0 100 Trying Via: SIP/2.0/UDP 172.20.1.204:5066;branch=z9hG4bKQ3Qym8BcyZU8K;received=172.20.1.204;rport=5066 From: <sip:6492810587@172.20.1.204:5066><mailto:sip:6492810587@172.20.1.204:5066>;tag=t8tK0r0750cHj To: "Anonymous" <sip:6499196120@172.20.1.201:5061><mailto:sip:6499196120@172.20.1.201:5061>;tag=as02ccecfe Call-ID: 419a7a7d150b4049389c91f1109676d4(a)172.20.1.201<mailto:419a7a7d150b4049389c91f1109676d4@172.20.1.201> CSeq: 56734943 INVITE Server: iTalk Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Contact: <sip:6499196120@172.20.1.201:5061><mailto:sip:6499196120@172.20.1.201:5061> Content-Length: 0 ------------------------------------------------------------------------ tport.c:3031 tport_deliver() tport_deliver(0x1eb4080): msg 0x7ff100055140 (515 bytes) from udp/172.20.1.201:5066/sip next=(nil) nta.c:3222 agent_recv_response() nta: received 100 Trying for INVITE (56734943) nta.c:3285 agent_recv_response() nta: 100 Trying is going to a transaction nta.c:9450 outgoing_estimate_delay() nta_outgoing: RTT is 1.549 ms tport.c:4230 tport_release() tport_release(0x1eb4080): 0x7ff10004f7e0 by 0x7ff1000296f0 with 0x7ff100055140 (preliminary) tport.c:2757 tport_wakeup_pri() tport_wakeup_pri(0x1eb4080): events IN tport.c:2872 tport_recv_event() tport_recv_event(0x1eb4080) tport.c:3213 tport_recv_iovec() tport_recv_iovec(0x1eb4080) msg 0x7ff100055140 from (udp/172.20.1.204:5066) has 765 bytes, veclen = 1 recv 765 bytes from udp/[172.20.1.201]:5061 at 21:40:15.047085: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 172.20.1.204:5066;branch=z9hG4bKQ3Qym8BcyZU8K;received=172.20.1.204;rport=5066 From: <sip:6492810587@172.20.1.204:5066><mailto:sip:6492810587@172.20.1.204:5066>;tag=t8tK0r0750cHj To: "Anonymous" <sip:6499196120@172.20.1.201:5061><mailto:sip:6499196120@172.20.1.201:5061>;tag=as02ccecfe Call-ID: 419a7a7d150b4049389c91f1109676d4(a)172.20.1.201<mailto:419a7a7d150b4049389c91f1109676d4@172.20.1.201> CSeq: 56734943 INVITE Server: iTalk Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH Supported: replaces, timer Contact: <sip:6499196120@172.20.1.201:5061><mailto:sip:6499196120@172.20.1.201:5061> Content-Type: application/sdp Content-Length: 221 v=0 o=root 1737995898 1737995899 IN IP4 172.20.1.201 s=iTalk c=IN IP4 172.20.1.201 t=0 0 m=audio 10418 RTP/AVP 8 101 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=ptime:20 a=recvonly ------------------------------------------------------------------------ tport.c:3031 tport_deliver() tport_deliver(0x1eb4080): msg 0x7ff100055140 (765 bytes) from udp/172.20.1.201:5066/sip next=(nil) nta.c:3222 agent_recv_response() nta: received 200 OK for INVITE (56734943) nta.c:3285 agent_recv_response() nta: 200 OK is going to a transaction tport.c:4230 tport_release() tport_release(0x1eb4080): 0x7ff10004f7e0 by 0x7ff1000296f0 with 0x7ff100055140 soa.c:1171 soa_set_remote_sdp() soa_set_remote_sdp(static::0x7ff1000085e0, (nil), 0x7ff100058790, 221) called soa.c:1595 soa_process_answer() soa_process_answer(static::0x7ff1000085e0) called soa_static.c:1137 offer_answer_step() soa_static_offer_answer_action(0x7ff1000085e0, soa_process_answer): called soa_static.c:1020 soa_sdp_mode_set() soa_sdp_mode_set(0x7ff100050010, 0x7ff10005cbf0, "*"): called soa_static.c:1283 offer_answer_step() soa_static(0x7ff1000085e0, soa_process_answer): upgrade codecs with remote description soa.c:1730 soa_activate() soa_activate(static::0x7ff1000085e0, (nil)) called nua_session.c:988 nua_session_client_response() nua(0x7ff100007ce0): INVITE: processed SDP answer in 200 OK nua_stack.c:271 nua_stack_event() nua(0x7ff100007ce0): event r_invite 200 OK nua_session.c:4143 signal_call_state_change() nua(0x7ff100007ce0): ready call updated: completing received answer soa.c:1098 soa_get_remote_sdp() soa_get_remote_sdp(static::0x7ff1000085e0, [0x7ff10e3a23a8], [0x7ff10e3a23b0], [(nil)]) called soa.c:616 soa_get_params() soa_get_params(static::0x7ff1000085e0, ...) called nua_stack.c:271 nua_stack_event() nua(0x7ff100007ce0): event i_state 200 OK 2014-03-07 10:20:03.151602 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.151602 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:API uuid: nua_stack.c:359 nua_application_event() nua: nua_application_event: entering 2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1049 Send signal sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061> [BREAK] nua_stack.c:359 nua_application_event() nua: nua_application_event: entering 2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1049 Send signal sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061> [BREAK] 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:API uuid: 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_CALLSTATE6ed900e4-2f0e-4a92-8b3e-f10c990d007a->Channel-Call-State:HELD 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_CALLSTATE6ed900e4-2f0e-4a92-8b3e-f10c990d007a->Original-Channel-Call-State:ACTIVE 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CHANNEL_HOLD uuid:6ed900e4-2f0e-4a92-8b3e-f10c990d007a 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:API uuid: 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CALL_UPDATE uuid:67701a09-90d9-4b0e-a114-d7726ad8666b 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:API uuid: 2014-03-07 10:20:03.172884 [DEBUG] sofia.c:7858 dispatched freeswitch event for INFO nua.c:879 nua_respond() nua: nua_respond: entering nua_stack.c:573 nua_stack_signal() nua(0x2006920): recv signal r_respond 200 OK nua_params.c:480 nua_stack_set_params() nua: nua_stack_set_params: entering soa.c:405 soa_set_params() soa_set_params(static::0x7ff100006590, ...) called tport.c:3265 tport_tsend() tport_tsend(0x1eb4080) tpn = UDP/10.15.1.2:5060 tport.c:4054 tport_resolve() tport_resolve addrinfo = 10.15.1.2:5060 tport.c:4688 tport_by_addrinfo() tport_by_addrinfo(0x1eb4080): not found by name UDP/10.15.1.2:5060 tport.c:3602 tport_vsend() tport_vsend(0x1eb4080): 505 bytes of 505 to udp/10.15.1.2:5060 tport.c:3500 tport_send_msg() tport_vsend returned 505 send 505 bytes to udp/[10.15.1.2]:5060 at 21:40:15.056080: ------------------------------------------------------------------------ SIP/2.0 200 OK Via: SIP/2.0/UDP 10.15.1.2:5060;branch=z9hG4bKsj7nji107oa0fl40r561.1 From: <sip:6492810587@10.15.1.2><mailto:sip:6492810587@10.15.1.2>;tag=SDu03v199-0082-0000017d-0558i0 To: "Anonymous" <sip:6499196120@172.20.1.204><mailto:sip:6499196120@172.20.1.204>;tag=UHmc2KHB3923D Call-ID: b4407d44-201a-1232-1f9d-000c2963be0e CSeq: 1 INFO User-Agent: FreeSWITCH-mod_sofia/1.5.8b+git~20140219T211351Z~bf9e3a1f9e~64bit Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY Supported: timer, path, replaces Content-Length: 0 ------------------------------------------------------------------------ nta.c:6690 incoming_reply() nta: sent 200 OK for INFO (1) nua_stack.c:529 nua_signal() nua(0x2006920): sent signal r_respond nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering 2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:647 BRIDGE THREAD DONE [sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2>] 2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:672 Send signal sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061> [BREAK] 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:533 (sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2>) State EXCHANGE_MEDIA going to sleep 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:467 (sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2>) Running State Change CS_HIBERNATE 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_STATE:67701a09-90d9-4b0e-a114-d7726ad8666b->CS_HIBERNATE 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:545 (sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2>) State HIBERNATE 2014-03-07 10:20:03.172884 [DEBUG] mod_sofia.c:160 sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> SOFIA HIBERNATE 2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:816 (sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2>) State Change CS_HIBERNATE -> CS_RESET 2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> [BREAK] 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:545 (sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2>) State HIBERNATE going to sleep 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:467 (sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2>) Running State Change CS_RESET 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_STATE:67701a09-90d9-4b0e-a114-d7726ad8666b->CS_RESET 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:526 (sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2>) State RESET 2014-03-07 10:20:03.172884 [DEBUG] mod_sofia.c:141 sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> SOFIA RESET 2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:801 sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> CUSTOM RESET 2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:808 (sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2>) State Change CS_RESET -> CS_SOFT_EXECUTE 2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> [BREAK] 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:526 (sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2>) State RESET going to sleep 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:467 (sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2>) Running State Change CS_SOFT_EXECUTE 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_STATE:67701a09-90d9-4b0e-a114-d7726ad8666b->CS_SOFT_EXECUTE 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:536 (sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2>) State SOFT_EXECUTE 2014-03-07 10:20:03.172884 [DEBUG] mod_sofia.c:598 SOFIA SOFT_EXECUTE 2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:826 sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> CUSTOM SOFT_EXECUTE 2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:647 BRIDGE THREAD DONE [sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061>] 2014-03-07 10:20:03.172884 [NOTICE] switch_ivr_bridge.c:660 Hangup sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> [CS_SOFT_EXECUTE] [NORMAL_CLEARING] 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CHANNEL_HANGUP uuid:67701a09-90d9-4b0e-a114-d7726ad8666b 2014-03-07 10:20:03.172884 [DEBUG] switch_channel.c:3212 Send signal sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> [KILL] 2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> [BREAK] 2014-03-07 10:20:03.172884 [DEBUG] switch_channel.c:1963 (sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061>) Callstate Change HELD -> UNHOLD 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_CALLSTATE6ed900e4-2f0e-4a92-8b3e-f10c990d007a->Channel-Call-State:UNHOLD 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_CALLSTATE6ed900e4-2f0e-4a92-8b3e-f10c990d007a->Original-Channel-Call-State:HELD 2014-03-07 10:20:03.172884 [DEBUG] switch_channel.c:1974 (sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061>) Callstate Change UNHOLD -> ACTIVE 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_CALLSTATE6ed900e4-2f0e-4a92-8b3e-f10c990d007a->Channel-Call-State:ACTIVE 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_CALLSTATE6ed900e4-2f0e-4a92-8b3e-f10c990d007a->Original-Channel-Call-State:UNHOLD 2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:672 Send signal sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> [BREAK] 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CHANNEL_UNBRIDGE uuid:6ed900e4-2f0e-4a92-8b3e-f10c990d007a 2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:1538 sofia/external/6492810587(a)10.15.1.2<mailto:sofia/external/6492810587@10.15.1.2> skip receive message [UNBRIDGE] (channel is hungup already) nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering 2014-03-07 10:20:03.172884 [DEBUG] sofia.c:5931 Channel sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061> entering state [calling][0] nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering 2014-03-07 10:20:03.172884 [DEBUG] sofia.c:5931 Channel sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061> entering state [completing][200] 2014-03-07 10:20:03.172884 [DEBUG] sofia.c:5941 Remote SDP: v=0 o=root 1737995898 1737995899 IN IP4 172.20.1.201 s=iTalk c=IN IP4 172.20.1.201 t=0 0 m=audio 10418 RTP/AVP 8 101 a=rtpmap:8 PCMA/8000 a=rtpmap:101 telephone-event/8000 a=fmtp:101 0-16 a=recvonly a=ptime:20 nua.c:639 nua_ack() nua: nua_ack: entering nua_stack.c:569 nua_stack_signal() nua(0x7ff100007ce0): recv signal r_ack nua_params.c:480 nua_stack_set_params() nua: nua_stack_set_params: entering soa.c:405 soa_set_params() soa_set_params(static::0x7ff1000085e0, ...) called soa.c:1730 soa_activate() soa_activate(static::0x7ff1000085e0, (nil)) called nta.c:2663 nta_tpn_by_url() nta: selecting scheme sip tport.c:3265 tport_tsend() tport_tsend(0x1eb4080) tpn = */172.20.1.201:5061 tport.c:4054 tport_resolve() tport_resolve addrinfo = 172.20.1.201:5061 tport.c:4688 tport_by_addrinfo() tport_by_addrinfo(0x1eb4080): not found by name */172.20.1.201:5061 tport.c:3602 tport_vsend() tport_vsend(0x1eb4080): 358 bytes of 358 to udp/172.20.1.201:5061 tport.c:3500 tport_send_msg() tport_vsend returned 358 send 358 bytes to udp/[172.20.1.201]:5061 at 21:40:15.062583: ------------------------------------------------------------------------ ACK sip:6499196120@172.20.1.201:5061<mailto:sip:6499196120@172.20.1.201:5061> SIP/2.0 Via: SIP/2.0/UDP 172.20.1.204:5066;rport;branch=z9hG4bKrcHQp3vFU8HUF Max-Forwards: 70 From: <sip:6492810587@172.20.1.204:5066><mailto:sip:6492810587@172.20.1.204:5066>;tag=t8tK0r0750cHj To: "Anonymous" <sip:6499196120@172.20.1.201:5061><mailto:sip:6499196120@172.20.1.201:5061>;tag=as02ccecfe Call-ID: 419a7a7d150b4049389c91f1109676d4(a)172.20.1.201<mailto:419a7a7d150b4049389c91f1109676d4@172.20.1.201> CSeq: 56734943 ACK Content-Length: 0 ------------------------------------------------------------------------ nta.c:8190 outgoing_send() nta: sent ACK (56734943) to */172.20.1.201:5061 nua_session.c:4143 signal_call_state_change() nua(0x7ff100007ce0): ready call updated: ready nua_stack.c:271 nua_stack_event() nua(0x7ff100007ce0): event i_state 200 ACK sent nua_stack.c:271 nua_stack_event() nua(0x7ff100007ce0): event i_active 200 Call active nua_stack.c:359 nua_application_event() nua: nua_application_event: entering 2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1049 Send signal sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061> [BREAK] nua_stack.c:359 nua_application_event() nua: nua_application_event: entering 2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1049 Send signal sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061> [BREAK] nua_stack.c:529 nua_signal() nua(0x7ff100007ce0): sent signal r_ack nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering 2014-03-07 10:20:03.172884 [DEBUG] sofia.c:5931 Channel sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061> entering state [ready][200] 2014-03-07 10:20:03.172884 [DEBUG] switch_core_media.c:3191 Audio Codec Compare [PCMA:8:8000:20:64000]/[G722:9:8000:20:64000] 2014-03-07 10:20:03.172884 [DEBUG] switch_core_media.c:3191 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMU:0:8000:20:64000] 2014-03-07 10:20:03.172884 [DEBUG] switch_core_media.c:3191 Audio Codec Compare [PCMA:8:8000:20:64000]/[PCMA:8:8000:20:64000] 2014-03-07 10:20:03.172884 [DEBUG] switch_core_media.c:3245 Audio Codec Compare [PCMA:8:8000:20:64000] ++++ is saved as a match 2014-03-07 10:20:03.172884 [DEBUG] switch_core_media.c:3191 Audio Codec Compare [PCMA:8:8000:20:64000]/[GSM:3:8000:20:13200] 2014-03-07 10:20:03.172884 [DEBUG] switch_core_media.c:3117 Set telephone-event payload to 101 2014-03-07 10:20:03.172884 [DEBUG] switch_core_media.c:3427 Set 2833 dtmf send/recv payload to 101 nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering nua.c:366 nua_handle_magic() nua: nua_handle_magic: entering 2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:904 Send signal sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061> [BREAK] 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CHANNEL_EXECUTE_COMPLETE uuid:6ed900e4-2f0e-4a92-8b3e-f10c990d007a 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CHANNEL_EXECUTE_COMPLETEapp:bridge data:sofia/external/6492810587@10.15.1.2<mailto:data:sofia/external/6492810587@10.15.1.2> 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:530 (sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061>) State EXECUTE going to sleep 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:467 (sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061>) Running State Change CS_PARK 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_STATE:6ed900e4-2f0e-4a92-8b3e-f10c990d007a->CS_PARK 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:539 (sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061>) State PARK 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:334 sofia/external/6499196120@172.20.1.201:5061<mailto:sofia/external/6499196120@172.20.1.201:5061> Standard PARK 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CHANNEL_PARK uuid:6ed900e4-2f0e-4a92-8b3e-f10c990d007a 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG: name:CHANNEL_UNPARK uuid:ed3aabd0-9f2e-4b2d-a9c6-a468e9e2966e 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:539 (sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061>) State PARK going to sleep 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:467 (sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061>) Running State Change CS_HIBERNATE 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_STATE:ed3aabd0-9f2e-4b2d-a9c6-a468e9e2966e->CS_HIBERNATE 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:545 (sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061>) State HIBERNATE 2014-03-07 10:20:03.172884 [DEBUG] mod_sofia.c:160 sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061> SOFIA HIBERNATE 2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:816 (sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061>) State Change CS_HIBERNATE -> CS_RESET 2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061> [BREAK] 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:545 (sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061>) State HIBERNATE going to sleep 2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:467 (sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061>) Running State Change CS_RESET 2014-03-07 10:20:03.172884 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.172884 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_STATE:ed3aabd0-9f2e-4b2d-a9c6-a468e9e2966e->CS_RESET 2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:526 (sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061>) State RESET 2014-03-07 10:20:03.191760 [DEBUG] mod_sofia.c:141 sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061> SOFIA RESET 2014-03-07 10:20:03.191760 [DEBUG] switch_ivr_bridge.c:801 sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061> CUSTOM RESET 2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:116 sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061> Standard RESET 2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:526 (sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061>) State RESET going to sleep 2014-03-07 10:20:03.191760 [DEBUG] switch_core_media.c:2063 Already using PCMA 2014-03-07 10:20:03.191760 [DEBUG] switch_ivr_originate.c:859 (sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061>) State Change CS_RESET -> CS_SOFT_EXECUTE 2014-03-07 10:20:03.191760 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061> [BREAK] 2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:467 (sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061>) Running State Change CS_SOFT_EXECUTE 2014-03-07 10:20:03.191760 [DEBUG] mod_lua.cpp:454 lua event hook: execute 'all_events.lua' 2014-03-07 10:20:03.191760 [DEBUG] switch_cpp.cpp:1293 Lua all_events.lua 2014-03-07 10:20:03.191760 [DEBUG] switch_cpp.cpp:1293 ALL EVENT DEBUG:CHANNEL_STATE:ed3aabd0-9f2e-4b2d-a9c6-a468e9e2966e->CS_SOFT_EXECUTE 2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:536 (sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061>) State SOFT_EXECUTE 2014-03-07 10:20:03.191760 [DEBUG] mod_sofia.c:598 SOFIA SOFT_EXECUTE 2014-03-07 10:20:03.191760 [DEBUG] switch_ivr_bridge.c:826 sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061> CUSTOM SOFT_EXECUTE 2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:328 sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061> Standard SOFT_EXECUTE 2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:536 (sofia/external/6499744915@172.20.1.201:5061<mailto:sofia/external/6499744915@172.20.1.201:5061>) State SOFT_EXECUTE going to sleep nta.c:8987 outgoing_timer_dk() nta: timer K fired, terminate INFO (56734935) nta.c:8685 outgoing_reclaim_queued() outgoing_reclaim_all((nil), (nil), 0x7ff10e3a2d40) nta.c:8815 _nta_outgoing_timer() nta_outgoing_timer: 0/0 resent, 0/2 tout, 1/3 term, 1/5 free nta.c:1294 agent_timer() nta: timer set next to 14232 ms freeswitch@internal> freeswitch@internal> freeswitch@internal> freeswitch@internal> freeswitch@internal> /exit Kevin Stewart Senior VOIP Network Engineer Direct: +64 9 919 6120 Mobile: 021 879057 Fax: +64 9 919 6121 Kevin Stewart Senior VOIP Network Engineer Direct: +64 9 919 6120 Mobile: 021 879057 Fax: +64 9 919 6121 [www.callplus.co.nz]<http://www.callplus.co.nz/> [100% Kiwi owned] [www.slingshot.co.nz] <http://www.slingshot.co.nz/> This message and any attachments contain privileged and confidential information. If you are not the intended recipient of this message, you are hereby notified that any use, dissemination, distribution or reproduction of this message is prohibited. If you have received this message in error please notify the sender immediately via email and then destroy this message and any attachments.

1 0