[Freeswitch-users] Call waiting implementation in LUA
Kevin Stewart
Kevin.Stewart at callplus.co.nz
Fri Mar 7 04:06:00 MSK 2014
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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 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 at 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 at 172.20.1.204:5066<mailto:sip:mod_sofia at 172.20.1.204:5066> SIP/2.0
Via: SIP/2.0/UDP 10.15.1.2:5060;branch=z9hG4bKsj7nji107oa0fl40r561.1
From: <sip:6492810587 at 10.15.1.2><mailto:sip:6492810587 at 10.15.1.2>;tag=SDu03v199-0082-0000017d-0558i0
To: "Anonymous" <sip:6499196120 at 172.20.1.204><mailto:sip:6499196120 at 172.20.1.204>;tag=UHmc2KHB3923D
Call-ID: b4407d44-201a-1232-1f9d-000c2963be0e
CSeq: 1 INFO
Max-Forwards: 28
Contact: "6492810587" <sip:6492810587 at 10.15.1.2:5060;transport=udp><mailto:sip:6492810587 at 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 at 172.20.1.204:5066<mailto:sip:mod_sofia at 172.20.1.204:5066> SIP/2.0 (CSeq 1)
nta.c:3171 agent_aliases() nta: canonizing sip:mod_sofia at 172.20.1.204:5066<mailto:sip:mod_sofia at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 172.20.1.201:5061> [BREAK]
2014-03-07 10:20:03.151602 [DEBUG] switch_ivr.c:2891 (sofia/external/6492810587 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 10.15.1.2> [BREAK]
2014-03-07 10:20:03.151602 [DEBUG] switch_channel.c:1789 (sofia/external/6499196120 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 172.20.1.201:5061>) Callstate Change ACTIVE -> HELD
2014-03-07 10:20:03.151602 [DEBUG] sofia_glue.c:1225 sofia/external/6499196120 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 172.20.1.201:5061> [BREAK]
2014-03-07 10:20:03.151602 [DEBUG] switch_core_session.c:1184 Send signal sofia/external/6492810587 at 10.15.1.2<mailto:sofia/external/6492810587 at 10.15.1.2> [BREAK]
2014-03-07 10:20:03.151602 [INFO] switch_channel.c:3057 sofia/external/6492810587 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 10.15.1.2> [BREAK]
2014-03-07 10:20:03.151602 [DEBUG] switch_ivr_bridge.c:1848 (sofia/external/6499744915 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 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 at 172.20.1.201:5061<mailto:sip:6499196120 at 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 at 172.20.1.204:5066><mailto:sip:6492810587 at 172.20.1.204:5066>;tag=t8tK0r0750cHj
To: "Anonymous" <sip:6499196120 at 172.20.1.201:5061><mailto:sip:6499196120 at 172.20.1.201:5061>;tag=as02ccecfe
Call-ID: 419a7a7d150b4049389c91f1109676d4 at 172.20.1.201<mailto:419a7a7d150b4049389c91f1109676d4 at 172.20.1.201>
CSeq: 56734943 INVITE
Contact: <sip:6492810587 at 172.20.1.204:5066;transport=udp><mailto:sip:6492810587 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 172.20.1.204:5066><mailto:sip:6492810587 at 172.20.1.204:5066>;tag=t8tK0r0750cHj
To: "Anonymous" <sip:6499196120 at 172.20.1.201:5061><mailto:sip:6499196120 at 172.20.1.201:5061>;tag=as02ccecfe
Call-ID: 419a7a7d150b4049389c91f1109676d4 at 172.20.1.201<mailto:419a7a7d150b4049389c91f1109676d4 at 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 at 172.20.1.201:5061><mailto:sip:6499196120 at 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 at 172.20.1.204:5066><mailto:sip:6492810587 at 172.20.1.204:5066>;tag=t8tK0r0750cHj
To: "Anonymous" <sip:6499196120 at 172.20.1.201:5061><mailto:sip:6499196120 at 172.20.1.201:5061>;tag=as02ccecfe
Call-ID: 419a7a7d150b4049389c91f1109676d4 at 172.20.1.201<mailto:419a7a7d150b4049389c91f1109676d4 at 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 at 172.20.1.201:5061><mailto:sip:6499196120 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 10.15.1.2><mailto:sip:6492810587 at 10.15.1.2>;tag=SDu03v199-0082-0000017d-0558i0
To: "Anonymous" <sip:6499196120 at 172.20.1.204><mailto:sip:6499196120 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 10.15.1.2>]
2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:672 Send signal sofia/external/6499196120 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 172.20.1.201:5061> [BREAK]
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:533 (sofia/external/6492810587 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 10.15.1.2>) State HIBERNATE
2014-03-07 10:20:03.172884 [DEBUG] mod_sofia.c:160 sofia/external/6492810587 at 10.15.1.2<mailto:sofia/external/6492810587 at 10.15.1.2> SOFIA HIBERNATE
2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:816 (sofia/external/6492810587 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 10.15.1.2> [BREAK]
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:545 (sofia/external/6492810587 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 10.15.1.2>) State RESET
2014-03-07 10:20:03.172884 [DEBUG] mod_sofia.c:141 sofia/external/6492810587 at 10.15.1.2<mailto:sofia/external/6492810587 at 10.15.1.2> SOFIA RESET
2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:801 sofia/external/6492810587 at 10.15.1.2<mailto:sofia/external/6492810587 at 10.15.1.2> CUSTOM RESET
2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:808 (sofia/external/6492810587 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 10.15.1.2> [BREAK]
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:526 (sofia/external/6492810587 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 172.20.1.201:5061>]
2014-03-07 10:20:03.172884 [NOTICE] switch_ivr_bridge.c:660 Hangup sofia/external/6492810587 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 10.15.1.2> [KILL]
2014-03-07 10:20:03.172884 [DEBUG] switch_core_session.c:1384 Send signal sofia/external/6492810587 at 10.15.1.2<mailto:sofia/external/6492810587 at 10.15.1.2> [BREAK]
2014-03-07 10:20:03.172884 [DEBUG] switch_channel.c:1963 (sofia/external/6499196120 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 10.15.1.2<mailto:sofia/external/6492810587 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 172.20.1.201:5061<mailto:sip:6499196120 at 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 at 172.20.1.204:5066><mailto:sip:6492810587 at 172.20.1.204:5066>;tag=t8tK0r0750cHj
To: "Anonymous" <sip:6499196120 at 172.20.1.201:5061><mailto:sip:6499196120 at 172.20.1.201:5061>;tag=as02ccecfe
Call-ID: 419a7a7d150b4049389c91f1109676d4 at 172.20.1.201<mailto:419a7a7d150b4049389c91f1109676d4 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 10.15.1.2<mailto:data:sofia/external/6492810587 at 10.15.1.2>
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:530 (sofia/external/6499196120 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 172.20.1.201:5061>) State PARK
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:334 sofia/external/6499196120 at 172.20.1.201:5061<mailto:sofia/external/6499196120 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 172.20.1.201:5061>) State HIBERNATE
2014-03-07 10:20:03.172884 [DEBUG] mod_sofia.c:160 sofia/external/6499744915 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 172.20.1.201:5061> SOFIA HIBERNATE
2014-03-07 10:20:03.172884 [DEBUG] switch_ivr_bridge.c:816 (sofia/external/6499744915 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 172.20.1.201:5061> [BREAK]
2014-03-07 10:20:03.172884 [DEBUG] switch_core_state_machine.c:545 (sofia/external/6499744915 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 172.20.1.201:5061>) State RESET
2014-03-07 10:20:03.191760 [DEBUG] mod_sofia.c:141 sofia/external/6499744915 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 172.20.1.201:5061> SOFIA RESET
2014-03-07 10:20:03.191760 [DEBUG] switch_ivr_bridge.c:801 sofia/external/6499744915 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 172.20.1.201:5061> CUSTOM RESET
2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:116 sofia/external/6499744915 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 172.20.1.201:5061> Standard RESET
2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:526 (sofia/external/6499744915 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 172.20.1.201:5061> [BREAK]
2014-03-07 10:20:03.191760 [DEBUG] switch_core_state_machine.c:467 (sofia/external/6499744915 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 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 at 172.20.1.201:5061<mailto:sofia/external/6499744915 at 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 at internal>
freeswitch at internal>
freeswitch at internal>
freeswitch at internal>
freeswitch at 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.
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20140307/ce847f83/attachment-0001.html
-------------- next part --------------
A non-text attachment was scrubbed...
Name: image78ff5b.JPG
Type: image/jpeg
Size: 12043 bytes
Desc: image78ff5b.JPG
Url : http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20140307/ce847f83/attachment-0003.jpe
-------------- next part --------------
A non-text attachment was scrubbed...
Name: image497da1.JPG
Type: image/jpeg
Size: 3094 bytes
Desc: image497da1.JPG
Url : http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20140307/ce847f83/attachment-0004.jpe
-------------- next part --------------
A non-text attachment was scrubbed...
Name: imagec0b098.JPG
Type: image/jpeg
Size: 5557 bytes
Desc: imagec0b098.JPG
Url : http://lists.freeswitch.org/pipermail/freeswitch-users/attachments/20140307/ce847f83/attachment-0005.jpe
Join us at ClueCon 2013 Aug 6-8, 2013
More information about the FreeSWITCH-users
mailing list