Skip to content

Instantly share code, notes, and snippets.

@neerajnagi
Created August 29, 2013 23:30
Show Gist options
  • Save neerajnagi/6384677 to your computer and use it in GitHub Desktop.
Save neerajnagi/6384677 to your computer and use it in GitHub Desktop.
ahn + fs + trace
</stream:features>
[2013-08-29 19:28:21] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-0.8.7/lib/blather/stream/features/sasl.rb:177:in `authenticate') <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">MUA1NC4yMTMuNTguOTQAMQAx</auth>
[2013-08-29 19:28:21] TRACE Punchblock::Connection::XMPP: RECEIVING (success) <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/>
[2013-08-29 19:28:21] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-0.8.7/lib/blather/stream/client.rb:12:in `start') <stream:stream to='54.213.58.94' xmlns='jabber:client' xmlns:stream='http://etherx.jabber.org/streams' version='1.0' xml:lang='en'>
[2013-08-29 19:28:21] TRACE Punchblock::Connection::XMPP: RECEIVING (stream) <stream:stream xmlns:db="jabber:server:dialback" xmlns:stream="http://etherx.jabber.org/streams" from="54.213.58.94" id="b152d344-1102-11e3-9940-5d997994877d" lang="en" version="1.0"/>
[2013-08-29 19:28:21] TRACE Punchblock::Connection::XMPP: RECEIVING (features) <stream:features xmlns:stream="http://etherx.jabber.org/streams">
<bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/>
<session xmlns="urn:ietf:params:xml:ns:xmpp-session"/>
</stream:features>
[2013-08-29 19:28:21] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-0.8.7/lib/blather/stream/features/resource.rb:39:in `bind') <iq type="set" id="blather000a">
<bind xmlns="urn:ietf:params:xml:ns:xmpp-bind">
<resource>ip-172-31-41-127.us-west-2.compute.internal-2670</resource>
</bind>
</iq>
[2013-08-29 19:28:21] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq type="result" id="blather000a">
<bind xmlns="urn:ietf:params:xml:ns:xmpp-bind">
<jid>1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670</jid>
</bind>
</iq>
[2013-08-29 19:28:21] TRACE Punchblock::Connection::XMPP: USING JID: 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670
[2013-08-29 19:28:21] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-0.8.7/lib/blather/stream/features/session.rb:40:in `session') <iq type="set" id="blather000c" to="54.213.58.94">
<session xmlns="urn:ietf:params:xml:ns:xmpp-session"/>
</iq>
[2013-08-29 19:28:21] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="54.213.58.94" type="result" id="blather000c"/>
[2013-08-29 19:28:21] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-0.8.7/lib/blather/client/client.rb:149:in `write') <iq type="get" id="blather000e">
<query xmlns="jabber:iq:roster"/>
</iq>
[2013-08-29 19:28:21] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq type="error" id="blather000e" to="1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670" from="54.213.58.94">
<query xmlns="jabber:iq:roster"/>
<error type="modify">
<feature-not-implemented xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"/>
</error>
</iq>
[2013-08-29 19:28:21] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-0.8.7/lib/blather/client/client.rb:149:in `write') <presence/>
[2013-08-29 19:28:21] INFO Punchblock::Connection::XMPP: Connected to XMPP as 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670
[2013-08-29 19:28:21] INFO Adhearsion::PunchblockPlugin::Initializer: Connected to Punchblock server
[2013-08-29 19:28:21] INFO Adhearsion::Process: Transitioning from booting to running with 0 active calls due to booted event.
[2013-08-29 19:28:39] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94" to="1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670">
<offer xmlns="urn:xmpp:rayo:1" from="sip:1001@54.213.58.94" to="sip:1002@54.213.58.94">
<header name="from" value="&lt;sip:1001@54.213.58.94&gt;;tag=b5efyFyBmzy0z43a1JQe"/>
<header name="to" value="&lt;sip:1002@54.213.58.94&gt;"/>
<header name="via" value="SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKgwhqgOF9NAbFgnSlNI4o5TiQhuT59Nm8;rport=62159;received=202.157.93.2"/>
</offer>
</presence>
[2013-08-29 19:28:39] DEBUG Adhearsion::Call: @: Receiving message: #<Punchblock::Event::Offer target_call_id="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5", target_mixer_name=nil, component_id=nil, domain="54.213.58.94", transport="xmpp", headers={"from"=>"<sip:1001@54.213.58.94>;tag=b5efyFyBmzy0z43a1JQe", "to"=>"<sip:1002@54.213.58.94>", "via"=>"SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKgwhqgOF9NAbFgnSlNI4o5TiQhuT59Nm8;rport=62159;received=202.157.93.2"}, to="sip:1002@54.213.58.94", from="sip:1001@54.213.58.94">
[2013-08-29 19:28:39] INFO Adhearsion::Router: Call 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5 selected route "default" (Incomming)
[2013-08-29 19:28:39] DEBUG Adhearsion::Call: 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: Executing command #<Punchblock::Command::Accept target_call_id=nil, target_mixer_name=nil, component_id=nil, domain=nil, transport=nil, headers={}>
[2013-08-29 19:28:39] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-0.8.7/lib/blather/client/client.rb:149:in `write') <iq type="set" to="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94" id="blather0010">
<accept xmlns="urn:xmpp:rayo:1"/>
</iq>
[2013-08-29 19:28:39] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94" to="1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670" type="result" id="blather0010"/>
[2013-08-29 19:28:39] INFO Adhearsion::Call: 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: Executing controller #<Incomming call=43db6fba-343c-6c55-0de0-8c3e2fe6b8c5, metadata={}>
[2013-08-29 19:28:39] DEBUG Adhearsion::Call: 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: Receiving message: #<Punchblock::Event::Offer target_call_id="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5", target_mixer_name=nil, component_id=nil, domain="54.213.58.94", transport="xmpp", headers={"from"=>"<sip:1001@54.213.58.94>;tag=b5efyFyBmzy0z43a1JQe", "to"=>"<sip:1002@54.213.58.94>", "via"=>"SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKgwhqgOF9NAbFgnSlNI4o5TiQhuT59Nm8;rport=62159;received=202.157.93.2"}, to="sip:1002@54.213.58.94", from="sip:1001@54.213.58.94">
[2013-08-29 19:28:39] INFO Adhearsion::Call: 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: incoming call from 1001 --> 1002
[2013-08-29 19:28:39] INFO Adhearsion::Call: 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: #<Adhearsion::Call:43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94 offer=#<Punchblock::Event::Offer target_call_id="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5", target_mixer_name=nil, component_id=nil, domain="54.213.58.94", transport="xmpp", headers={"from"=>"<sip:1001@54.213.58.94>;tag=b5efyFyBmzy0z43a1JQe", "to"=>"<sip:1002@54.213.58.94>", "via"=>"SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKgwhqgOF9NAbFgnSlNI4o5TiQhuT59Nm8;rport=62159;received=202.157.93.2"}, to="sip:1002@54.213.58.94", from="sip:1001@54.213.58.94">, end_reason=nil, commands=[], variables={"from"=>"<sip:1001@54.213.58.94>;tag=b5efyFyBmzy0z43a1JQe", "to"=>"<sip:1002@54.213.58.94>", "via"=>"SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKgwhqgOF9NAbFgnSlNI4o5TiQhuT59Nm8;rport=62159;received=202.157.93.2"}, controllers=[#<Incomming call=43db6fba-343c-6c55-0de0-8c3e2fe6b8c5, metadata={}>], to="sip:1002@54.213.58.94", from="sip:1001@54.213.58.94">
[2013-08-29 19:28:39] DEBUG Adhearsion::Call: 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: Executing command #<Punchblock::Command::Answer target_call_id=nil, target_mixer_name=nil, component_id=nil, domain=nil, transport=nil, headers={}>
[2013-08-29 19:28:39] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-0.8.7/lib/blather/client/client.rb:149:in `write') <iq type="set" to="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94" id="blather0012">
<answer xmlns="urn:xmpp:rayo:1"/>
</iq>
[2013-08-29 19:28:39] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94" to="1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670" type="result" id="blather0012"/>
[2013-08-29 19:28:39] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94" to="1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670">
<answered xmlns="urn:xmpp:rayo:1"/>
</presence>
[2013-08-29 19:28:39] DEBUG Adhearsion::Call: 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: Receiving message: #<Punchblock::Event::Answered target_call_id="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5", target_mixer_name=nil, component_id=nil, domain="54.213.58.94", transport="xmpp", headers={}>
[2013-08-29 19:28:39] DEBUG Adhearsion::Call: 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: Executing command #<Punchblock::Component::Output target_call_id=nil, target_mixer_name=nil, component_id=nil, domain=nil, transport=nil, voice=nil, interrupt_on=nil, start_offset=nil, start_paused=false, repeat_interval=nil, repeat_times=nil, max_time=nil, renderer=nil, render_documents=[#<Punchblock::Component::Output::Document target_call_id=nil, target_mixer_name=nil, component_id=nil, domain=nil, transport=nil, url=nil, content_type="application/ssml+xml", value=<speak xmlns="http://www.w3.org/2001/10/synthesis" version="1.0" xml:lang="en-US">
<audio src="/var/punchblock/record/welcome.mp3"/>
</speak>>]>
[2013-08-29 19:28:39] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-0.8.7/lib/blather/client/client.rb:149:in `write') <iq type="set" to="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94" id="blather0014">
<output xmlns="urn:xmpp:rayo:output:1" start-paused="false">
<document content-type="application/ssml+xml"><![CDATA[<speak xmlns="http://www.w3.org/2001/10/synthesis" version="1.0" xml:lang="en-US">
<audio src="/var/punchblock/record/welcome.mp3"/>
</speak>]]></document>
</output>
</iq>
[2013-08-29 19:28:39] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94" to="1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670" type="result" id="blather0014">
<ref xmlns="urn:xmpp:rayo:1" uri="xmpp:43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1"/>
</iq>
[2013-08-29 19:28:39] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1" to="1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670" type="unavailable">
<complete xmlns="urn:xmpp:rayo:ext:1">
<error xmlns="urn:xmpp:rayo:ext:complete:1"/>
</complete>
</presence>
[2013-08-29 19:28:39] ERROR Adhearsion::Call: 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: <Adhearsion::CallController::Output::PlaybackError> Output failed due to #<Adhearsion::Error: : #<Punchblock::Component::Output target_call_id="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5", target_mixer_name=nil, component_id="output-1", domain="54.213.58.94", transport=nil, voice=nil, interrupt_on=nil, start_offset=nil, start_paused=false, repeat_interval=nil, repeat_times=nil, max_time=nil, renderer=nil, render_documents=[#<Punchblock::Component::Output::Document target_call_id=nil, target_mixer_name=nil, component_id=nil, domain=nil, transport=nil, url=nil, content_type="application/ssml+xml", value=<speak xmlns="http://www.w3.org/2001/10/synthesis" version="1.0" xml:lang="en-US">
<audio src="/var/punchblock/record/welcome.mp3"/>
</speak>>]>>
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/adhearsion-2.4.0/lib/adhearsion/call_controller/output/player.rb:23:in `rescue in output'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/adhearsion-2.4.0/lib/adhearsion/call_controller/output/player.rb:13:in `output'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/adhearsion-2.4.0/lib/adhearsion/call_controller/output/abstract_player.rb:18:in `play_ssml'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/adhearsion-2.4.0/lib/adhearsion/call_controller/output.rb:141:in `play_audio'
/root/clicktocall_rayo/lib/incomming.rb:31:in `run'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/adhearsion-2.4.0/lib/adhearsion/call_controller.rb:119:in `execute!'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/adhearsion-2.4.0/lib/adhearsion/call_controller.rb:94:in `block in exec'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/adhearsion-2.4.0/lib/adhearsion/call_controller.rb:93:in `catch'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/adhearsion-2.4.0/lib/adhearsion/call_controller.rb:93:in `exec'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/adhearsion-2.4.0/lib/adhearsion/call_controller.rb:110:in `exec_with_callback'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/adhearsion-2.4.0/lib/adhearsion/call_controller.rb:104:in `block (2 levels) in bg_exec'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/adhearsion-2.4.0/lib/adhearsion/foundation/exception_handler.rb:5:in `catching_standard_errors'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/adhearsion-2.4.0/lib/adhearsion/call_controller.rb:103:in `block in bg_exec'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/celluloid-0.14.1/lib/celluloid/thread_handle.rb:13:in `block in initialize'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/celluloid-0.14.1/lib/celluloid/internal_pool.rb:59:in `call'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/celluloid-0.14.1/lib/celluloid/internal_pool.rb:59:in `block in create'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/logging-1.8.1/lib/logging/diagnostic_context.rb:323:in `call'
/usr/local/rvm/gems/ruby-2.0.0-p247/gems/logging-1.8.1/lib/logging/diagnostic_context.rb:323:in `block in create_with_logging_context'
[2013-08-29 19:28:40] DEBUG Adhearsion::Call: 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: Receiving message: #<Punchblock::Event::Complete target_call_id="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5", target_mixer_name=nil, component_id="output-1", domain="54.213.58.94", transport="xmpp", reason=#<Punchblock::Event::Complete::Error target_call_id=nil, target_mixer_name=nil, component_id=nil, domain=nil, transport=nil, name=:error, details="">, recording=nil>
[2013-08-29 19:28:40] DEBUG Adhearsion::Call: 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: Finished executing controller #<Incomming call=43db6fba-343c-6c55-0de0-8c3e2fe6b8c5, metadata={}>
[2013-08-29 19:28:40] INFO Adhearsion::Call: 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: Hanging up
[2013-08-29 19:28:40] DEBUG Adhearsion::Call: 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: Executing command #<Punchblock::Command::Hangup target_call_id=nil, target_mixer_name=nil, component_id=nil, domain=nil, transport=nil, headers={}>
[2013-08-29 19:28:40] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-0.8.7/lib/blather/client/client.rb:149:in `write') <iq type="set" to="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94" id="blather0016">
<hangup xmlns="urn:xmpp:rayo:1"/>
</iq>
[2013-08-29 19:28:40] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94" to="1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670" type="result" id="blather0016"/>
[2013-08-29 19:28:40] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94" to="1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670" type="unavailable">
<end xmlns="urn:xmpp:rayo:1">
<hangup-command/>
</end>
</presence>
[2013-08-29 19:28:40] DEBUG Adhearsion::Call: 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: Receiving message: #<Punchblock::Event::End target_call_id="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5", target_mixer_name=nil, component_id=nil, domain="54.213.58.94", transport="xmpp", headers={}, reason=:"hangup-command", platform_code=nil>
[2013-08-29 19:28:40] INFO Adhearsion::Call: 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: Call ended due to hangup-command
freeswitch trace
ype = NODE_NORMAL
2013-08-29 19:28:22.072005 [DEBUG] xmpp_streams.c:287 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670, presence, state = READY
2013-08-29 19:28:22.072005 [DEBUG] mod_rayo.c:3010 Lock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:28:22.072005 [DEBUG] mod_rayo.c:2310 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 got empty presence
2013-08-29 19:28:22.072005 [DEBUG] mod_rayo.c:2331 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 is ONLINE
2013-08-29 19:28:22.072005 [DEBUG] mod_rayo.c:3076 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:28:39.870964 [NOTICE] switch_channel.c:1030 New Channel sofia/internal/1001@54.213.58.94 [43db6fba-343c-6c55-0de0-8c3e2fe6b8c5]
2013-08-29 19:28:39.870964 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/1001@54.213.58.94 [BREAK]
2013-08-29 19:28:39.870964 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/1001@54.213.58.94 [BREAK]
2013-08-29 19:28:39.870964 [DEBUG] switch_core_state_machine.c:416 (sofia/internal/1001@54.213.58.94) Running State Change CS_NEW
2013-08-29 19:28:39.870964 [DEBUG] switch_core_state_machine.c:434 (sofia/internal/1001@54.213.58.94) State NEW
2013-08-29 19:28:39.870964 [DEBUG] sofia.c:7906 IP 202.157.93.2 Approved by acl "domains[]". Access Granted.
2013-08-29 19:28:39.870964 [DEBUG] sofia.c:8925 Setting NAT mode based on via received
2013-08-29 19:28:39.870964 [DEBUG] sofia.c:5793 Channel sofia/internal/1001@54.213.58.94 entering state [received][100]
2013-08-29 19:28:39.870964 [DEBUG] sofia.c:5802 Remote SDP:
v=0
o=- 477315452371321340 2 IN IP4 127.0.0.1
s=Doubango Telecom - chrome
t=0 0
a=group:BUNDLE audio video
a=msid-semantic: WMS lV9LezmjQyGbf1Fwh3mMbL9dMGYfAU0fVzjg
m=audio 54247 RTP/SAVPF 111 103 104 0 8 107 106 105 13 126
c=IN IP4 202.157.93.2
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:107 CN/48000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:126 telephone-event/8000
a=rtcp:54247 IN IP4 202.157.93.2
a=candidate:524234378 1 udp 2113937151 10.100.101.254 54247 typ host generation 0
a=candidate:524234378 2 udp 2113937151 10.100.101.254 54247 typ host generation 0
a=candidate:3551662361 1 udp 1845501695 202.157.93.2 54247 typ srflx raddr 10.100.101.254 rport 54247 generation 0
a=candidate:3551662361 2 udp 1845501695 202.157.93.2 54247 typ srflx raddr 10.100.101.254 rport 54247 generation 0
a=candidate:1371329146 1 tcp 1509957375 10.100.101.254 0 typ host generation 0
a=candidate:1371329146 2 tcp 1509957375 10.100.101.254 0 typ host generation 0
a=ice-ufrag:QVIet8IdJ4Epb7NW
a=ice-pwd:4W9ibRyVCJCqXPb5hXxuZfsm
a=ice-options:google-ice
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=mid:audio
a=rtcp-mux
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:zehWqlzYkkQlk6A+AHatyKdq2MT0of39bu+mugj7
a=maxptime:60
a=ssrc:1152824513 cname:98i9IjPECDDuI7UZ
a=ssrc:1152824513 msid:lV9LezmjQyGbf1Fwh3mMbL9dMGYfAU0fVzjg lV9LezmjQyGbf1Fwh3mMbL9dMGYfAU0fVzjga0
a=ssrc:1152824513 mslabel:lV9LezmjQyGbf1Fwh3mMbL9dMGYfAU0fVzjg
a=ssrc:1152824513 label:lV9LezmjQyGbf1Fwh3mMbL9dMGYfAU0fVzjga0
m=video 54247 RTP/SAVPF 100 116 117
c=IN IP4 202.157.93.2
a=rtpmap:100 VP8/90000
a=rtpmap:116 red/90000
a=rtpmap:117 ulpfec/90000
a=rtcp:54247 IN IP4 202.157.93.2
a=candidate:524234378 1 udp 2113937151 10.100.101.254 54247 typ host generation 0
a=candidate:524234378 2 udp 2113937151 10.100.101.254 54247 typ host generation 0
a=candidate:3551662361 1 udp 1845501695 202.157.93.2 54247 typ srflx raddr 10.100.101.254 rport 54247 generation 0
a=candidate:3551662361 2 udp 1845501695 202.157.93.2 54247 typ srflx raddr 10.100.101.254 rport 54247 generation 0
a=candidate:1371329146 1 tcp 1509957375 10.100.101.254 0 typ host generation 0
a=candidate:1371329146 2 tcp 1509957375 10.100.101.254 0 typ host generation 0
a=ice-ufrag:QVIet8IdJ4Epb7NW
a=ice-pwd:4W9ibRyVCJCqXPb5hXxuZfsm
a=ice-options:google-ice
a=extmap:2 urn:ietf:params:rtp-hdrext:toffset
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=mid:video
a=rtcp-mux
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:zehWqlzYkkQlk6A+AHatyKdq2MT0of39bu+mugj7
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 goog-remb
2013-08-29 19:28:39.870964 [DEBUG] sofia.c:6015 (sofia/internal/1001@54.213.58.94) State Change CS_NEW -> CS_INIT
2013-08-29 19:28:39.870964 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/1001@54.213.58.94 [BREAK]
2013-08-29 19:28:39.870964 [DEBUG] switch_core_state_machine.c:416 (sofia/internal/1001@54.213.58.94) Running State Change CS_INIT
2013-08-29 19:28:39.870964 [DEBUG] switch_core_state_machine.c:455 (sofia/internal/1001@54.213.58.94) State INIT
2013-08-29 19:28:39.870964 [DEBUG] mod_sofia.c:87 sofia/internal/1001@54.213.58.94 SOFIA INIT
2013-08-29 19:28:39.870964 [DEBUG] mod_sofia.c:114 (sofia/internal/1001@54.213.58.94) State Change CS_INIT -> CS_ROUTING
2013-08-29 19:28:39.870964 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/1001@54.213.58.94 [BREAK]
2013-08-29 19:28:39.870964 [DEBUG] switch_core_state_machine.c:455 (sofia/internal/1001@54.213.58.94) State INIT going to sleep
2013-08-29 19:28:39.870964 [DEBUG] switch_core_state_machine.c:416 (sofia/internal/1001@54.213.58.94) Running State Change CS_ROUTING
2013-08-29 19:28:39.870964 [DEBUG] switch_channel.c:2116 (sofia/internal/1001@54.213.58.94) Callstate Change DOWN -> RINGING
2013-08-29 19:28:39.870964 [DEBUG] switch_core_state_machine.c:471 (sofia/internal/1001@54.213.58.94) State ROUTING
2013-08-29 19:28:39.870964 [DEBUG] mod_sofia.c:137 sofia/internal/1001@54.213.58.94 SOFIA ROUTING
2013-08-29 19:28:39.870964 [DEBUG] switch_core_state_machine.c:117 sofia/internal/1001@54.213.58.94 Standard ROUTING
2013-08-29 19:28:39.870964 [INFO] mod_dialplan_xml.c:558 Processing 1001 <1001>->1002 in context public
Dialplan: sofia/internal/1001@54.213.58.94 parsing [public->public_did] continue=false
Dialplan: sofia/internal/1001@54.213.58.94 Regex (FAIL) [public_did] destination_number(1002) =~ /^(5551212)$/ break=on-false
Dialplan: sofia/internal/1001@54.213.58.94 parsing [public->conferences_10000] continue=false
Dialplan: sofia/internal/1001@54.213.58.94 Regex (FAIL) [conferences_10000] destination_number(1002) =~ /^(10000)$/ break=on-false
Dialplan: sofia/internal/1001@54.213.58.94 parsing [public->conferences_123123123123] continue=false
Dialplan: sofia/internal/1001@54.213.58.94 Regex (FAIL) [conferences_123123123123] destination_number(1002) =~ /^(123123123123)$/ break=on-false
Dialplan: sofia/internal/1001@54.213.58.94 parsing [public->conferences_2354] continue=false
Dialplan: sofia/internal/1001@54.213.58.94 Regex (FAIL) [conferences_2354] destination_number(1002) =~ /^(2354)$/ break=on-false
Dialplan: sofia/internal/1001@54.213.58.94 parsing [public->conferences_2355] continue=false
Dialplan: sofia/internal/1001@54.213.58.94 Regex (FAIL) [conferences_2355] destination_number(1002) =~ /^(2355)$/ break=on-false
Dialplan: sofia/internal/1001@54.213.58.94 parsing [public->conferences_2356] continue=false
Dialplan: sofia/internal/1001@54.213.58.94 Regex (FAIL) [conferences_2356] destination_number(1002) =~ /^(2356)$/ break=on-false
Dialplan: sofia/internal/1001@54.213.58.94 parsing [public->conferences_2722249814] continue=false
Dialplan: sofia/internal/1001@54.213.58.94 Regex (FAIL) [conferences_2722249814] destination_number(1002) =~ /^(2722249814)$/ break=on-false
Dialplan: sofia/internal/1001@54.213.58.94 parsing [public->conferences_800] continue=false
Dialplan: sofia/internal/1001@54.213.58.94 Regex (FAIL) [conferences_800] destination_number(1002) =~ /^(800)$/ break=on-false
Dialplan: sofia/internal/1001@54.213.58.94 parsing [public->conferences_800100] continue=false
Dialplan: sofia/internal/1001@54.213.58.94 Regex (FAIL) [conferences_800100] destination_number(1002) =~ /^(800100)$/ break=on-false
Dialplan: sofia/internal/1001@54.213.58.94 parsing [public->conferences_Raj2] continue=false
Dialplan: sofia/internal/1001@54.213.58.94 Regex (FAIL) [conferences_Raj2] destination_number(1002) =~ /^(Raj2)$/ break=on-false
Dialplan: sofia/internal/1001@54.213.58.94 parsing [public->conferences_RajRoom] continue=false
Dialplan: sofia/internal/1001@54.213.58.94 Regex (FAIL) [conferences_RajRoom] destination_number(1002) =~ /^(RajRoom)$/ break=on-false
Dialplan: sofia/internal/1001@54.213.58.94 parsing [public->conferences_monu_ki_conference] continue=false
Dialplan: sofia/internal/1001@54.213.58.94 Regex (FAIL) [conferences_monu_ki_conference] destination_number(1002) =~ /^(conference_monu_ki_conference)$/ break=on-false
Dialplan: sofia/internal/1001@54.213.58.94 parsing [public->sunil_conferences] continue=false
Dialplan: sofia/internal/1001@54.213.58.94 Regex (FAIL) [sunil_conferences] destination_number(1002) =~ /^2353$/ break=on-false
Dialplan: sofia/internal/1001@54.213.58.94 parsing [public->Adhearsion] continue=false
Dialplan: sofia/internal/1001@54.213.58.94 Regex (PASS) [Adhearsion] destination_number(1002) =~ /.*$/ break=on-false
Dialplan: sofia/internal/1001@54.213.58.94 Action info()
Dialplan: sofia/internal/1001@54.213.58.94 Action set(is_parent_leg=yes)
Dialplan: sofia/internal/1001@54.213.58.94 Action set(hangup_after_bridge=false)
Dialplan: sofia/internal/1001@54.213.58.94 Action set(park_after_bridge=false)
Dialplan: sofia/internal/1001@54.213.58.94 Action set(domain_name=54.213.58.94)
Dialplan: sofia/internal/1001@54.213.58.94 Action rayo()
2013-08-29 19:28:39.870964 [DEBUG] switch_core_state_machine.c:167 (sofia/internal/1001@54.213.58.94) State Change CS_ROUTING -> CS_EXECUTE
2013-08-29 19:28:39.870964 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/1001@54.213.58.94 [BREAK]
2013-08-29 19:28:39.870964 [DEBUG] switch_core_state_machine.c:471 (sofia/internal/1001@54.213.58.94) State ROUTING going to sleep
2013-08-29 19:28:39.870964 [DEBUG] switch_core_state_machine.c:416 (sofia/internal/1001@54.213.58.94) Running State Change CS_EXECUTE
2013-08-29 19:28:39.870964 [DEBUG] switch_core_state_machine.c:478 (sofia/internal/1001@54.213.58.94) State EXECUTE
2013-08-29 19:28:39.870964 [DEBUG] mod_sofia.c:230 sofia/internal/1001@54.213.58.94 SOFIA EXECUTE
2013-08-29 19:28:39.870964 [DEBUG] switch_core_state_machine.c:209 sofia/internal/1001@54.213.58.94 Standard EXECUTE
EXECUTE sofia/internal/1001@54.213.58.94 info()
2013-08-29 19:28:39.870964 [INFO] mod_dptools.c:1586 CHANNEL_DATA:
Channel-State: [CS_EXECUTE]
Channel-Call-State: [RINGING]
Channel-State-Number: [4]
Channel-Name: [sofia/internal/1001@54.213.58.94]
Unique-ID: [43db6fba-343c-6c55-0de0-8c3e2fe6b8c5]
Call-Direction: [inbound]
Presence-Call-Direction: [inbound]
Channel-HIT-Dialplan: [true]
Channel-Presence-ID: [1001@54.213.58.94]
Channel-Call-UUID: [43db6fba-343c-6c55-0de0-8c3e2fe6b8c5]
Answer-State: [ringing]
Caller-Direction: [inbound]
Caller-Username: [1001]
Caller-Dialplan: [XML]
Caller-Caller-ID-Name: [1001]
Caller-Caller-ID-Number: [1001]
Caller-Orig-Caller-ID-Name: [1001]
Caller-Orig-Caller-ID-Number: [1001]
Caller-Network-Addr: [202.157.93.2]
Caller-ANI: [1001]
Caller-Destination-Number: [1002]
Caller-Unique-ID: [43db6fba-343c-6c55-0de0-8c3e2fe6b8c5]
Caller-Source: [mod_sofia]
Caller-Context: [public]
Caller-Channel-Name: [sofia/internal/1001@54.213.58.94]
Caller-Profile-Index: [1]
Caller-Profile-Created-Time: [1377818919870964]
Caller-Channel-Created-Time: [1377818919870964]
Caller-Channel-Answered-Time: [0]
Caller-Channel-Progress-Time: [0]
Caller-Channel-Progress-Media-Time: [0]
Caller-Channel-Hangup-Time: [0]
Caller-Channel-Transfer-Time: [0]
Caller-Channel-Resurrect-Time: [0]
Caller-Channel-Bridged-Time: [0]
Caller-Channel-Last-Hold: [0]
Caller-Channel-Hold-Accum: [0]
Caller-Screen-Bit: [true]
Caller-Privacy-Hide-Name: [false]
Caller-Privacy-Hide-Number: [false]
variable_direction: [inbound]
variable_uuid: [43db6fba-343c-6c55-0de0-8c3e2fe6b8c5]
variable_session_id: [23]
variable_sip_from_user: [1001]
variable_sip_from_uri: [1001@54.213.58.94]
variable_sip_from_host: [54.213.58.94]
variable_channel_name: [sofia/internal/1001@54.213.58.94]
variable_sip_call_id: [43db6fba-343c-6c55-0de0-8c3e2fe6b8c5]
variable_sip_local_network_addr: [54.213.58.94]
variable_sip_network_ip: [202.157.93.2]
variable_sip_network_port: [62159]
variable_sip_received_ip: [202.157.93.2]
variable_sip_received_port: [62159]
variable_sip_via_protocol: [ws]
variable_sip_authorized: [true]
variable_sip_acl_authed_by: [domains]
variable_sip_from_user_stripped: [1001]
variable_sip_from_tag: [b5efyFyBmzy0z43a1JQe]
variable_sofia_profile_name: [internal]
variable_recovery_profile_name: [internal]
variable_sip_full_via: [SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKgwhqgOF9NAbFgnSlNI4o5TiQhuT59Nm8;rport=62159;received=202.157.93.2]
variable_sip_full_from: [<sip:1001@54.213.58.94>;tag=b5efyFyBmzy0z43a1JQe]
variable_sip_full_to: [<sip:1002@54.213.58.94>]
variable_sip_req_user: [1002]
variable_sip_req_uri: [1002@54.213.58.94]
variable_sip_req_host: [54.213.58.94]
variable_sip_to_user: [1002]
variable_sip_to_uri: [1002@54.213.58.94]
variable_sip_to_host: [54.213.58.94]
variable_sip_contact_params: [rtcweb-breaker=no;click2call=no;transport=ws]
variable_sip_contact_user: [1001]
variable_sip_contact_uri: [1001@df7jal23ls0d.invalid]
variable_sip_contact_host: [df7jal23ls0d.invalid]
variable_rtp_use_codec_string: [G722,PCMU,PCMA,GSM]
variable_sip_user_agent: [IM-client/OMA1.0 sipML5-v1.2013.05.24]
variable_sip_via_host: [df7jal23ls0d.invalid]
variable_sip_via_rport: [62159]
variable_max_forwards: [70]
variable_presence_id: [1001@54.213.58.94]
variable_sip_nat_detected: [true]
variable_switch_r_sdp: [v=0
o=- 477315452371321340 2 IN IP4 127.0.0.1
s=Doubango Telecom - chrome
t=0 0
a=group:BUNDLE audio video
a=msid-semantic: WMS lV9LezmjQyGbf1Fwh3mMbL9dMGYfAU0fVzjg
m=audio 54247 RTP/SAVPF 111 103 104 0 8 107 106 105 13 126
c=IN IP4 202.157.93.2
a=rtpmap:111 opus/48000/2
a=fmtp:111 minptime=10
a=rtpmap:103 ISAC/16000
a=rtpmap:104 ISAC/32000
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:107 CN/48000
a=rtpmap:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:126 telephone-event/8000
a=rtcp:54247 IN IP4 202.157.93.2
a=candidate:524234378 1 udp 2113937151 10.100.101.254 54247 typ host generation 0
a=candidate:524234378 2 udp 2113937151 10.100.101.254 54247 typ host generation 0
a=candidate:3551662361 1 udp 1845501695 202.157.93.2 54247 typ srflx raddr 10.100.101.254 rport 54247 generation 0
a=candidate:3551662361 2 udp 1845501695 202.157.93.2 54247 typ srflx raddr 10.100.101.254 rport 54247 generation 0
a=candidate:1371329146 1 tcp 1509957375 10.100.101.254 0 typ host generation 0
a=candidate:1371329146 2 tcp 1509957375 10.100.101.254 0 typ host generation 0
a=ice-ufrag:QVIet8IdJ4Epb7NW
a=ice-pwd:4W9ibRyVCJCqXPb5hXxuZfsm
a=ice-options:google-ice
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=mid:audio
a=rtcp-mux
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:zehWqlzYkkQlk6A+AHatyKdq2MT0of39bu+mugj7
a=maxptime:60
a=ssrc:1152824513 cname:98i9IjPECDDuI7UZ
a=ssrc:1152824513 msid:lV9LezmjQyGbf1Fwh3mMbL9dMGYfAU0fVzjg lV9LezmjQyGbf1Fwh3mMbL9dMGYfAU0fVzjga0
a=ssrc:1152824513 mslabel:lV9LezmjQyGbf1Fwh3mMbL9dMGYfAU0fVzjg
a=ssrc:1152824513 label:lV9LezmjQyGbf1Fwh3mMbL9dMGYfAU0fVzjga0
m=video 54247 RTP/SAVPF 100 116 117
c=IN IP4 202.157.93.2
a=rtpmap:100 VP8/90000
a=rtpmap:116 red/90000
a=rtpmap:117 ulpfec/90000
a=rtcp:54247 IN IP4 202.157.93.2
a=candidate:524234378 1 udp 2113937151 10.100.101.254 54247 typ host generation 0
a=candidate:524234378 2 udp 2113937151 10.100.101.254 54247 typ host generation 0
a=candidate:3551662361 1 udp 1845501695 202.157.93.2 54247 typ srflx raddr 10.100.101.254 rport 54247 generation 0
a=candidate:3551662361 2 udp 1845501695 202.157.93.2 54247 typ srflx raddr 10.100.101.254 rport 54247 generation 0
a=candidate:1371329146 1 tcp 1509957375 10.100.101.254 0 typ host generation 0
a=candidate:1371329146 2 tcp 1509957375 10.100.101.254 0 typ host generation 0
a=ice-ufrag:QVIet8IdJ4Epb7NW
a=ice-pwd:4W9ibRyVCJCqXPb5hXxuZfsm
a=ice-options:google-ice
a=extmap:2 urn:ietf:params:rtp-hdrext:toffset
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=mid:video
a=rtcp-mux
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:zehWqlzYkkQlk6A+AHatyKdq2MT0of39bu+mugj7
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 goog-remb
]
variable_ep_codec_string: [PCMU@8000h@20i@64000b,PCMA@8000h@20i@64000b]
variable_endpoint_disposition: [DELAYED NEGOTIATION]
variable_call_uuid: [43db6fba-343c-6c55-0de0-8c3e2fe6b8c5]
variable_current_application: [info]
EXECUTE sofia/internal/1001@54.213.58.94 set(is_parent_leg=yes)
2013-08-29 19:28:39.870964 [DEBUG] mod_dptools.c:1374 sofia/internal/1001@54.213.58.94 SET [is_parent_leg]=[yes]
EXECUTE sofia/internal/1001@54.213.58.94 set(hangup_after_bridge=false)
2013-08-29 19:28:39.870964 [DEBUG] mod_dptools.c:1374 sofia/internal/1001@54.213.58.94 SET [hangup_after_bridge]=[false]
EXECUTE sofia/internal/1001@54.213.58.94 set(park_after_bridge=false)
2013-08-29 19:28:39.870964 [DEBUG] mod_dptools.c:1374 sofia/internal/1001@54.213.58.94 SET [park_after_bridge]=[false]
EXECUTE sofia/internal/1001@54.213.58.94 set(domain_name=54.213.58.94)
2013-08-29 19:28:39.870964 [DEBUG] mod_dptools.c:1374 sofia/internal/1001@54.213.58.94 SET [domain_name]=[54.213.58.94]
EXECUTE sofia/internal/1001@54.213.58.94 rayo()
2013-08-29 19:28:39.870964 [DEBUG] mod_rayo.c:2938 Init 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94
2013-08-29 19:28:39.870964 [DEBUG] mod_rayo.c:2943 Offering call for Rayo 3PCC
2013-08-29 19:28:39.870964 [DEBUG] mod_rayo.c:624 Locate 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:28:39.870964 [DEBUG] mod_rayo.c:2961 Deliver 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94 => 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 <presence from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670'><offer xmlns='urn:xmpp:rayo:1' from='sip:1001@54.213.58.94' to='sip:1002@54.213.58.94'><header name='from' value='&lt;sip:1001@54.213.58.94&gt;;tag=b5efyFyBmzy0z43a1JQe'/><header name='to' value='&lt;sip:1002@54.213.58.94&gt;'/><header name='via' value='SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKgwhqgOF9NAbFgnSlNI4o5TiQhuT59Nm8;rport=62159;received=202.157.93.2'/></offer></presence>
2013-08-29 19:28:39.870964 [DEBUG] mod_rayo.c:631 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:28:39.892696 [DEBUG] xmpp_streams.c:190 c2s_in 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 SEND <presence from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670'><offer xmlns='urn:xmpp:rayo:1' from='sip:1001@54.213.58.94' to='sip:1002@54.213.58.94'><header name='from' value='&lt;sip:1001@54.213.58.94&gt;;tag=b5efyFyBmzy0z43a1JQe'/><header name='to' value='&lt;sip:1002@54.213.58.94&gt;'/><header name='via' value='SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKgwhqgOF9NAbFgnSlNI4o5TiQhuT59Nm8;rport=62159;received=202.157.93.2'/></offer></presence>
2013-08-29 19:28:40.026346 [DEBUG] xmpp_streams.c:190 c2s_in 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 RECV <iq type="set" to="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94" id="blather0010"><accept xmlns="urn:xmpp:rayo:1"/></iq>
2013-08-29 19:28:40.026346 [DEBUG] xmpp_streams.c:1058 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670, state = READY, node type = NODE_NORMAL
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:3010 Lock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:2365 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670, recv iq, availability = ONLINE
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:3069 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:624 Locate 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: ref count = 2
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:2368 Deliver 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 => 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94 <iq type='set' to='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' id='blather0010' from='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670'><accept xmlns='urn:xmpp:rayo:1'/></iq>
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:505 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94, looking for CALL::set:urn:xmpp:rayo:1:accept command
2013-08-29 19:28:40.026346 [INFO] mod_rayo.c:1314 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 has control of call
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:1471 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94, executing command
2013-08-29 19:28:40.026346 [INFO] mod_rayo.c:1609 Sending early media
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:881 Set Remote Key [1 AES_CM_128_HMAC_SHA1_80 inline:zehWqlzYkkQlk6A+AHatyKdq2MT0of39bu+mugj7]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:682 Set Local Key [1 AES_CM_128_HMAC_SHA1_80 inline:EBuUUIkpIDx41zFyocTulRMHHtpNYk44wrOW0yvN]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2787 Audio Codec Compare [opus:111:48000:60:0]/[G722:9:8000:20:64000]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2787 Audio Codec Compare [opus:111:48000:60:0]/[PCMU:0:8000:20:64000]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2787 Audio Codec Compare [opus:111:48000:60:0]/[PCMA:8:8000:20:64000]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2787 Audio Codec Compare [opus:111:48000:60:0]/[GSM:3:8000:20:13200]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2787 Audio Codec Compare [ISAC:103:16000:30:32000]/[G722:9:8000:20:64000]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2787 Audio Codec Compare [ISAC:103:16000:30:32000]/[PCMU:0:8000:20:64000]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2787 Audio Codec Compare [ISAC:103:16000:30:32000]/[PCMA:8:8000:20:64000]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2787 Audio Codec Compare [ISAC:103:16000:30:32000]/[GSM:3:8000:20:13200]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2787 Audio Codec Compare [ISAC:104:32000:30:32000]/[G722:9:8000:20:64000]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2787 Audio Codec Compare [ISAC:104:32000:30:32000]/[PCMU:0:8000:20:64000]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2787 Audio Codec Compare [ISAC:104:32000:30:32000]/[PCMA:8:8000:20:64000]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2787 Audio Codec Compare [ISAC:104:32000:30:32000]/[GSM:3:8000:20:13200]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2787 Audio Codec Compare [PCMU:0:8000:60:64000]/[G722:9:8000:20:64000]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2787 Audio Codec Compare [PCMU:0:8000:60:64000]/[PCMU:0:8000:20:64000]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:1823 Set Codec sofia/internal/1001@54.213.58.94 PCMU/8000 20 ms 160 samples 64000 bits
2013-08-29 19:28:40.026346 [DEBUG] switch_core_codec.c:111 sofia/internal/1001@54.213.58.94 Original read codec set to PCMU:0
2013-08-29 19:28:40.026346 [WARNING] switch_core_media.c:2002 NO candidate ACL defined, Defaulting to wan.auto
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2026 Checking Candidate cid: 1 proto: udp type: host addr: 10.100.101.254:54247
2013-08-29 19:28:40.026346 [NOTICE] switch_core_media.c:2040 Save audio Candidate cid: 1 proto: udp type: host addr: 10.100.101.254:54247
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2026 Checking Candidate cid: 2 proto: udp type: host addr: 10.100.101.254:54247
2013-08-29 19:28:40.026346 [NOTICE] switch_core_media.c:2040 Save audio Candidate cid: 2 proto: udp type: host addr: 10.100.101.254:54247
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2026 Checking Candidate cid: 1 proto: udp type: srflx addr: 202.157.93.2:54247
2013-08-29 19:28:40.026346 [NOTICE] switch_core_media.c:2035 Choose audio Candidate cid: 1 proto: udp type: srflx addr: 202.157.93.2:54247
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2026 Checking Candidate cid: 2 proto: udp type: srflx addr: 202.157.93.2:54247
2013-08-29 19:28:40.026346 [NOTICE] switch_core_media.c:2035 Choose audio Candidate cid: 2 proto: udp type: srflx addr: 202.157.93.2:54247
2013-08-29 19:28:40.026346 [NOTICE] switch_core_media.c:2149 setting remote audio ice addr to 202.157.93.2:54247 based on candidate
2013-08-29 19:28:40.026346 [NOTICE] switch_core_media.c:2167 setting remote rtcp audio addr to 202.157.93.2:54247 based on candidate
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:2958 Set 2833 dtmf send/recv payload to 126
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:881 Set Remote Key [1 AES_CM_128_HMAC_SHA1_80 inline:zehWqlzYkkQlk6A+AHatyKdq2MT0of39bu+mugj7]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:682 Set Local Key [1 AES_CM_128_HMAC_SHA1_80 inline:wTQE0zQnzJvZ3NWGitOeQ0Ee57+Jaa6AOwRDlAsH]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:3986 AUDIO RTP [sofia/internal/1001@54.213.58.94] 172.31.41.127 port 25898 -> 202.157.93.2 port 54247 codec: 0 ms: 20
2013-08-29 19:28:40.026346 [DEBUG] switch_rtp.c:2885 Starting timer [soft] 160 bytes per 20ms
2013-08-29 19:28:40.026346 [INFO] switch_core_media.c:4149 Activating Audio ICE
2013-08-29 19:28:40.026346 [NOTICE] switch_rtp.c:3317 Activating RTP audio ICE: QVIet8IdJ4Epb7NW:eGlFy1CUaKO44QCx 202.157.93.2:54247
2013-08-29 19:28:40.026346 [INFO] switch_core_media.c:4192 Activating RTCP PORT 54247
2013-08-29 19:28:40.026346 [DEBUG] switch_rtp.c:3222 RTCP send rate is: 10000 and packet rate is: 20000 Remote Port: 54247
2013-08-29 19:28:40.026346 [DEBUG] switch_rtp.c:1858 Setting RTCP remote addr to 202.157.93.2:54247
2013-08-29 19:28:40.026346 [INFO] switch_core_media.c:4200 Skipping RTCP ICE (Same as RTP)
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:4320 Set 2833 dtmf send payload to 126
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:4326 Set 2833 dtmf receive payload to 126
2013-08-29 19:28:40.026346 [DEBUG] switch_core_media.c:4359 Set comfort noise payload to 107
2013-08-29 19:28:40.026346 [INFO] switch_rtp.c:2705 Activating Audio Secure RTP SEND
2013-08-29 19:28:40.026346 [INFO] switch_rtp.c:2683 Activating Audio Secure RTP RECV
2013-08-29 19:28:40.026346 [NOTICE] sofia_media.c:92 Pre-Answer sofia/internal/1001@54.213.58.94!
2013-08-29 19:28:40.026346 [DEBUG] switch_channel.c:3316 (sofia/internal/1001@54.213.58.94) Callstate Change RINGING -> EARLY
2013-08-29 19:28:40.026346 [DEBUG] mod_sofia.c:2105 Ring SDP:
v=0
o=FreeSWITCH 1377793022 1377793023 IN IP4 54.213.58.94
s=FreeSWITCH
c=IN IP4 54.213.58.94
t=0 0
a=msid-semantic: WMS OjWX94Hvcyy5iFJUKXw2B2P7wjh33tcH
m=audio 25898 RTP/SAVPF 0 126 107
a=rtpmap:0 PCMU/8000
a=rtpmap:126 telephone-event/8000
a=rtpmap:107 CN/8000
a=ptime:20
a=sendrecv
a=rtcp-mux
a=rtcp:25898 IN IP4 54.213.58.94
a=ssrc:1620024959 cname:DZuCT2XWqmRzSrkt
a=ssrc:1620024959 msid:OjWX94Hvcyy5iFJUKXw2B2P7wjh33tcH a0
a=ssrc:1620024959 mslabel:OjWX94Hvcyy5iFJUKXw2B2P7wjh33tcH
a=ssrc:1620024959 label:OjWX94Hvcyy5iFJUKXw2B2P7wjh33tcHa0
a=ice-ufrag:eGlFy1CUaKO44QCx
a=ice-pwd:FW0pPOb50TvJaF2e
a=candidate:8553901727 1 udp 659136 54.213.58.94 25898 typ host generation 0
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:EBuUUIkpIDx41zFyocTulRMHHtpNYk44wrOW0yvN
2013-08-29 19:28:40.026346 [DEBUG] switch_core_session.c:861 Send signal sofia/internal/1001@54.213.58.94 [BREAK]
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:1473 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94, done executing command
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:631 Unlock 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: ref count = 1
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:624 Locate 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:1480 Deliver 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94 => 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 <iq from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670' type='result' id='blather0010'/>
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:631 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:28:40.026346 [DEBUG] switch_core_sqldb.c:2352 Secure Type: srtp:sdes:AES_CM_128_HMAC_SHA1_80
2013-08-29 19:28:40.026346 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/1001@54.213.58.94 [BREAK]
2013-08-29 19:28:40.026346 [DEBUG] switch_core_sqldb.c:2352 Secure Type: srtp:sdes:AES_CM_128_HMAC_SHA1_80
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:2776 got event CHANNEL_PROGRESS_MEDIA
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:2781 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 rayo event CHANNEL_PROGRESS_MEDIA
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:2783 Locate 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:28:40.026346 [DEBUG] mod_rayo.c:2791 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:28:40.031170 [DEBUG] sofia.c:5793 Channel sofia/internal/1001@54.213.58.94 entering state [early][183]
2013-08-29 19:28:40.031170 [DEBUG] switch_ivr.c:951 Codec Activated L16@8000hz 1 channels 20ms
2013-08-29 19:28:40.031170 [DEBUG] xmpp_streams.c:190 c2s_in 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 SEND <iq from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670' type='result' id='blather0010'/>
2013-08-29 19:28:40.453714 [DEBUG] xmpp_streams.c:190 c2s_in 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 RECV <iq type="set" to="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94" id="blather0012"><answer xmlns="urn:xmpp:rayo:1"/></iq>
2013-08-29 19:28:40.453714 [DEBUG] xmpp_streams.c:1058 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670, state = READY, node type = NODE_NORMAL
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:3010 Lock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:2365 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670, recv iq, availability = ONLINE
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:3069 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:624 Locate 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: ref count = 2
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:2368 Deliver 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 => 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94 <iq type='set' to='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' id='blather0012' from='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670'><answer xmlns='urn:xmpp:rayo:1'/></iq>
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:505 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94, looking for CALL::set:urn:xmpp:rayo:1:answer command
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:1471 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94, executing command
2013-08-29 19:28:40.453714 [DEBUG] mod_sofia.c:822 Local SDP sofia/internal/1001@54.213.58.94:
v=0
o=FreeSWITCH 1377793022 1377793024 IN IP4 54.213.58.94
s=FreeSWITCH
c=IN IP4 54.213.58.94
t=0 0
a=msid-semantic: WMS OjWX94Hvcyy5iFJUKXw2B2P7wjh33tcH
m=audio 25898 RTP/SAVPF 0 126 107
a=rtpmap:0 PCMU/8000
a=rtpmap:126 telephone-event/8000
a=rtpmap:107 CN/8000
a=ptime:20
a=sendrecv
a=rtcp-mux
a=rtcp:25898 IN IP4 54.213.58.94
a=ssrc:1620024959 cname:DZuCT2XWqmRzSrkt
a=ssrc:1620024959 msid:OjWX94Hvcyy5iFJUKXw2B2P7wjh33tcH a0
a=ssrc:1620024959 mslabel:OjWX94Hvcyy5iFJUKXw2B2P7wjh33tcH
a=ssrc:1620024959 label:OjWX94Hvcyy5iFJUKXw2B2P7wjh33tcHa0
a=ice-ufrag:eGlFy1CUaKO44QCx
a=ice-pwd:FW0pPOb50TvJaF2e
a=candidate:7105405301 1 udp 659136 54.213.58.94 25898 typ host generation 0
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:EBuUUIkpIDx41zFyocTulRMHHtpNYk44wrOW0yvN
2013-08-29 19:28:40.453714 [DEBUG] switch_core_session.c:861 Send signal sofia/internal/1001@54.213.58.94 [BREAK]
2013-08-29 19:28:40.453714 [NOTICE] mod_rayo.c:1628 Channel [sofia/internal/1001@54.213.58.94] has been answered
2013-08-29 19:28:40.453714 [DEBUG] switch_channel.c:3595 (sofia/internal/1001@54.213.58.94) Callstate Change EARLY -> ACTIVE
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:1473 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94, done executing command
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:631 Unlock 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: ref count = 1
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:624 Locate 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:1480 Deliver 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94 => 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 <iq from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670' type='result' id='blather0012'/>
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:631 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:2776 got event CHANNEL_ANSWER
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:2781 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 rayo event CHANNEL_ANSWER
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:2783 Locate 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:2616 Locate 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: ref count = 2
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:2622 Unlock 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: ref count = 1
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:2791 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:624 Locate 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:2621 Deliver 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94 => 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 <presence from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670'><answered xmlns='urn:xmpp:rayo:1'/></presence>
2013-08-29 19:28:40.453714 [DEBUG] mod_rayo.c:631 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:28:40.453714 [DEBUG] switch_core_session.c:1006 Send signal sofia/internal/1001@54.213.58.94 [BREAK]
2013-08-29 19:28:40.453714 [DEBUG] sofia.c:5793 Channel sofia/internal/1001@54.213.58.94 entering state [completed][200]
2013-08-29 19:28:40.453714 [DEBUG] xmpp_streams.c:190 c2s_in 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 SEND <iq from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670' type='result' id='blather0012'/>
2013-08-29 19:28:40.453714 [DEBUG] xmpp_streams.c:190 c2s_in 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 SEND <presence from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670'><answered xmlns='urn:xmpp:rayo:1'/></presence>
2013-08-29 19:28:40.621673 [DEBUG] xmpp_streams.c:190 c2s_in 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 RECV <iq type="set" to="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94" id="blather0014"><output xmlns="urn:xmpp:rayo:output:1" start-paused="false"><document content-type="application/ssml+xml"><![CDATA[<speak xmlns="http://www.w3.org/2001/10/synthesis" version="1.0" xml:lang="en-US">
<audio src="/var/punchblock/record/welcome.mp3"/>
</speak>]]></document></output></iq>
2013-08-29 19:28:40.621673 [DEBUG] xmpp_streams.c:1058 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670, state = READY, node type = NODE_NORMAL
2013-08-29 19:28:40.621673 [DEBUG] mod_rayo.c:3010 Lock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:28:40.621673 [DEBUG] mod_rayo.c:2365 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670, recv iq, availability = ONLINE
2013-08-29 19:28:40.621673 [DEBUG] mod_rayo.c:3069 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:28:40.621673 [DEBUG] mod_rayo.c:624 Locate 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: ref count = 2
2013-08-29 19:28:40.621673 [DEBUG] mod_rayo.c:2368 Deliver 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 => 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94 <iq type='set' to='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' id='blather0014' from='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670'><output xmlns='urn:xmpp:rayo:output:1' start-paused='false'><document content-type='application/ssml+xml'>&lt;speak xmlns=&quot;http://www.w3.org/2001/10/synthesis&quot; version=&quot;1.0&quot; xml:lang=&quot;en-US&quot;&gt;
&lt;audio src=&quot;/var/punchblock/record/welcome.mp3&quot;/&gt;
&lt;/speak&gt;</document></output></iq>
2013-08-29 19:28:40.621673 [DEBUG] mod_rayo.c:505 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94, looking for CALL::set:urn:xmpp:rayo:output:1:output command
2013-08-29 19:28:40.621673 [DEBUG] mod_rayo.c:1471 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94, executing command
2013-08-29 19:28:40.621673 [DEBUG] rayo_output_component.c:67 Init 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1
2013-08-29 19:28:40.621673 [DEBUG] mod_rayo.c:1151 Lock 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: ref count = 3
2013-08-29 19:28:40.621673 [DEBUG] switch_event.c:1615 Parsing variable [id]=[43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1]
2013-08-29 19:28:40.621673 [DEBUG] switch_event.c:1615 Parsing variable [session]=[43db6fba-343c-6c55-0de0-8c3e2fe6b8c5]
2013-08-29 19:28:40.621673 [DEBUG] switch_event.c:1615 Parsing variable [pause]=[false]
2013-08-29 19:28:40.621673 [DEBUG] rayo_output_component.c:624 Got path rayo://43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1
2013-08-29 19:28:40.621673 [DEBUG] rayo_output_component.c:458 Got path 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1
2013-08-29 19:28:40.621673 [DEBUG] rayo_output_component.c:460 Locate 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1: ref count = 2
2013-08-29 19:28:40.621673 [ERR] switch_core_file.c:150 Invalid file format [ssml] for [<speak xmlns="http://www.w3.org/2001/10/synthesis" version="1.0" xml:lang="en-US">
<audio src="/var/punchblock/record/welcome.mp3"/>
</speak>]!
2013-08-29 19:28:40.621673 [INFO] rayo_output_component.c:425 Failed to open ssml://<speak xmlns="http://www.w3.org/2001/10/synthesis" version="1.0" xml:lang="en-US">
<audio src="/var/punchblock/record/welcome.mp3"/>
</speak>
2013-08-29 19:28:40.621673 [INFO] rayo_output_component.c:386 Done playing
2013-08-29 19:28:40.621673 [INFO] rayo_output_component.c:474 Status = 1
2013-08-29 19:28:40.621673 [DEBUG] rayo_output_component.c:475 Unlock 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1: ref count = 1
2013-08-29 19:28:40.621673 [DEBUG] rayo_components.c:116 Unlock 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1: ref count = 0
2013-08-29 19:28:40.621673 [DEBUG] rayo_components.c:117 Destroy 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1 requested: ref_count = 0
2013-08-29 19:28:40.621673 [DEBUG] rayo_components.c:117 Destroying 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1
2013-08-29 19:28:40.621673 [DEBUG] mod_rayo.c:1129 Unlock 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: ref count = 2
2013-08-29 19:28:40.621673 [DEBUG] mod_rayo.c:1473 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94, done executing command
2013-08-29 19:28:40.621673 [DEBUG] mod_rayo.c:631 Unlock 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: ref count = 1
2013-08-29 19:28:40.621673 [DEBUG] mod_rayo.c:624 Locate 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:28:40.621673 [DEBUG] rayo_components.c:62 Deliver 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1 => 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 <iq from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670' type='result' id='blather0014'><ref xmlns='urn:xmpp:rayo:1' uri='xmpp:43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1'/></iq>
2013-08-29 19:28:40.621673 [DEBUG] mod_rayo.c:631 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:28:40.621673 [DEBUG] mod_rayo.c:624 Locate 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:28:40.621673 [DEBUG] rayo_components.c:115 Deliver 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1 => 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 <presence from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670' type='unavailable'><complete xmlns='urn:xmpp:rayo:ext:1'><error xmlns='urn:xmpp:rayo:ext:complete:1'/></complete></presence>
2013-08-29 19:28:40.621673 [DEBUG] mod_rayo.c:631 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:28:40.621673 [DEBUG] xmpp_streams.c:190 c2s_in 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 SEND <iq from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670' type='result' id='blather0014'><ref xmlns='urn:xmpp:rayo:1' uri='xmpp:43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1'/></iq>
2013-08-29 19:28:40.621673 [DEBUG] xmpp_streams.c:190 c2s_in 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 SEND <presence from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94/output-1' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670' type='unavailable'><complete xmlns='urn:xmpp:rayo:ext:1'><error xmlns='urn:xmpp:rayo:ext:complete:1'/></complete></presence>
2013-08-29 19:28:40.733340 [DEBUG] xmpp_streams.c:190 c2s_in 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 RECV <iq type="set" to="43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94" id="blather0016"><hangup xmlns="urn:xmpp:rayo:1"/></iq>
2013-08-29 19:28:40.733340 [DEBUG] xmpp_streams.c:1058 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670, state = READY, node type = NODE_NORMAL
2013-08-29 19:28:40.733340 [DEBUG] mod_rayo.c:3010 Lock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:28:40.733340 [DEBUG] mod_rayo.c:2365 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670, recv iq, availability = ONLINE
2013-08-29 19:28:40.733340 [DEBUG] mod_rayo.c:3069 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:28:40.733340 [DEBUG] mod_rayo.c:624 Locate 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: ref count = 2
2013-08-29 19:28:40.733340 [DEBUG] mod_rayo.c:2368 Deliver 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 => 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94 <iq type='set' to='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' id='blather0016' from='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670'><hangup xmlns='urn:xmpp:rayo:1'/></iq>
2013-08-29 19:28:40.733340 [DEBUG] mod_rayo.c:505 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94, looking for CALL::set:urn:xmpp:rayo:1:hangup command
2013-08-29 19:28:40.733340 [DEBUG] mod_rayo.c:1471 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94, executing command
2013-08-29 19:28:40.733340 [NOTICE] switch_ivr.c:3701 Hangup sofia/internal/1001@54.213.58.94 [CS_EXECUTE] [NORMAL_CLEARING]
2013-08-29 19:28:40.733340 [DEBUG] switch_channel.c:3135 Send signal sofia/internal/1001@54.213.58.94 [KILL]
2013-08-29 19:28:40.733340 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/1001@54.213.58.94 [BREAK]
2013-08-29 19:28:40.733340 [DEBUG] mod_rayo.c:1473 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94, done executing command
2013-08-29 19:28:40.733340 [DEBUG] mod_rayo.c:631 Unlock 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: ref count = 1
2013-08-29 19:28:40.733340 [DEBUG] mod_rayo.c:624 Locate 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:28:40.733340 [DEBUG] mod_rayo.c:1480 Deliver 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94 => 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 <iq from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670' type='result' id='blather0016'/>
2013-08-29 19:28:40.733340 [DEBUG] mod_rayo.c:631 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:28:40.733340 [DEBUG] switch_core_session.c:2743 sofia/internal/1001@54.213.58.94 skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
2013-08-29 19:28:40.733340 [DEBUG] switch_core_state_machine.c:478 (sofia/internal/1001@54.213.58.94) State EXECUTE going to sleep
2013-08-29 19:28:40.733340 [DEBUG] switch_core_state_machine.c:416 (sofia/internal/1001@54.213.58.94) Running State Change CS_HANGUP
2013-08-29 19:28:40.733340 [DEBUG] switch_core_state_machine.c:679 (sofia/internal/1001@54.213.58.94) State HANGUP
2013-08-29 19:28:40.733340 [DEBUG] mod_sofia.c:463 Channel sofia/internal/1001@54.213.58.94 hanging up, cause: NORMAL_CLEARING
2013-08-29 19:28:40.759078 [DEBUG] xmpp_streams.c:190 c2s_in 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 SEND <iq from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670' type='result' id='blather0016'/>
2013-08-29 19:28:40.759078 [DEBUG] mod_sofia.c:515 Sending BYE to sofia/internal/1001@54.213.58.94
2013-08-29 19:28:40.759078 [DEBUG] switch_core_state_machine.c:48 sofia/internal/1001@54.213.58.94 Standard HANGUP, cause: NORMAL_CLEARING
2013-08-29 19:28:40.759078 [DEBUG] switch_core_state_machine.c:679 (sofia/internal/1001@54.213.58.94) State HANGUP going to sleep
2013-08-29 19:28:40.759078 [DEBUG] switch_core_state_machine.c:692 (sofia/internal/1001@54.213.58.94) Callstate Change ACTIVE -> HANGUP
2013-08-29 19:28:40.759078 [DEBUG] switch_core_state_machine.c:447 (sofia/internal/1001@54.213.58.94) State Change CS_HANGUP -> CS_REPORTING
2013-08-29 19:28:40.759078 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/1001@54.213.58.94 [BREAK]
2013-08-29 19:28:40.759078 [DEBUG] switch_core_state_machine.c:416 (sofia/internal/1001@54.213.58.94) Running State Change CS_REPORTING
2013-08-29 19:28:40.759078 [DEBUG] switch_core_state_machine.c:764 (sofia/internal/1001@54.213.58.94) State REPORTING
2013-08-29 19:28:40.759078 [DEBUG] switch_core_state_machine.c:92 sofia/internal/1001@54.213.58.94 Standard REPORTING, cause: NORMAL_CLEARING
2013-08-29 19:28:40.759078 [DEBUG] switch_core_state_machine.c:764 (sofia/internal/1001@54.213.58.94) State REPORTING going to sleep
2013-08-29 19:28:40.759078 [DEBUG] switch_core_state_machine.c:441 (sofia/internal/1001@54.213.58.94) State Change CS_REPORTING -> CS_DESTROY
2013-08-29 19:28:40.759078 [DEBUG] switch_core_session.c:1341 Send signal sofia/internal/1001@54.213.58.94 [BREAK]
2013-08-29 19:28:40.759078 [DEBUG] switch_core_session.c:1549 Session 23 (sofia/internal/1001@54.213.58.94) Locked, Waiting on external entities
2013-08-29 19:28:40.759078 [NOTICE] switch_core_session.c:1567 Session 23 (sofia/internal/1001@54.213.58.94) Ended
2013-08-29 19:28:40.759078 [NOTICE] switch_core_session.c:1571 Close Channel sofia/internal/1001@54.213.58.94 [CS_DESTROY]
2013-08-29 19:28:40.759078 [DEBUG] switch_core_state_machine.c:566 (sofia/internal/1001@54.213.58.94) Callstate Change HANGUP -> DOWN
2013-08-29 19:28:40.759078 [DEBUG] switch_core_state_machine.c:569 (sofia/internal/1001@54.213.58.94) Running State Change CS_DESTROY
2013-08-29 19:28:40.759078 [DEBUG] switch_core_state_machine.c:579 (sofia/internal/1001@54.213.58.94) State DESTROY
2013-08-29 19:28:40.759078 [DEBUG] mod_sofia.c:373 sofia/internal/1001@54.213.58.94 SOFIA DESTROY
2013-08-29 19:28:40.759078 [DEBUG] switch_core_state_machine.c:99 sofia/internal/1001@54.213.58.94 Standard DESTROY
2013-08-29 19:28:40.759078 [DEBUG] switch_core_state_machine.c:579 (sofia/internal/1001@54.213.58.94) State DESTROY going to sleep
2013-08-29 19:28:40.759078 [DEBUG] mod_rayo.c:2592 Locate 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: ref count = 2
2013-08-29 19:28:40.759078 [DEBUG] mod_rayo.c:2603 Unlock 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: ref count = 1
2013-08-29 19:28:40.759078 [DEBUG] mod_rayo.c:2604 Destroy 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94 requested: ref_count = 1
2013-08-29 19:28:40.759078 [DEBUG] mod_rayo.c:2605 Unlock 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94: ref count = 0
2013-08-29 19:28:40.759078 [DEBUG] mod_rayo.c:2605 Destroying 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94
2013-08-29 19:28:40.759078 [DEBUG] mod_rayo.c:929 Sending <end> to offered client 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670
2013-08-29 19:28:40.759078 [DEBUG] mod_rayo.c:624 Locate 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:28:40.759078 [DEBUG] mod_rayo.c:930 Deliver 43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94 => 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 <presence from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670' type='unavailable'><end xmlns='urn:xmpp:rayo:1'><hangup-command/></end></presence>
2013-08-29 19:28:40.759078 [DEBUG] mod_rayo.c:631 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:28:40.770739 [DEBUG] xmpp_streams.c:190 c2s_in 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 SEND <presence from='43db6fba-343c-6c55-0de0-8c3e2fe6b8c5@54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670' type='unavailable'><end xmlns='urn:xmpp:rayo:1'><hangup-command/></end></presence>
2013-08-29 19:29:22.069305 [DEBUG] xmpp_streams.c:190 c2s_in 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 RECV <iq type="get" to="54.213.58.94" id="blather0018"><ping xmlns="urn:xmpp:ping"/></iq>
2013-08-29 19:29:22.069305 [DEBUG] xmpp_streams.c:1058 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670, state = READY, node type = NODE_NORMAL
2013-08-29 19:29:22.069305 [DEBUG] mod_rayo.c:3010 Lock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:29:22.069305 [DEBUG] mod_rayo.c:2365 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670, recv iq, availability = ONLINE
2013-08-29 19:29:22.069305 [DEBUG] mod_rayo.c:3069 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:29:22.069305 [DEBUG] mod_rayo.c:624 Locate 54.213.58.94: ref count = 2
2013-08-29 19:29:22.069305 [DEBUG] mod_rayo.c:2368 Deliver 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 => 54.213.58.94 <iq type='get' to='54.213.58.94' id='blather0018' from='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670'><ping xmlns='urn:xmpp:ping'/></iq>
2013-08-29 19:29:22.069305 [DEBUG] mod_rayo.c:505 54.213.58.94, looking for SERVER::get:urn:xmpp:ping:ping command
2013-08-29 19:29:22.069305 [DEBUG] mod_rayo.c:631 Unlock 54.213.58.94: ref count = 1
2013-08-29 19:29:22.069305 [DEBUG] mod_rayo.c:624 Locate 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 2
2013-08-29 19:29:22.069305 [DEBUG] mod_rayo.c:1432 Deliver 54.213.58.94 => 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 <iq type='result' from='54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670' id='blather0018'/>
2013-08-29 19:29:22.069305 [DEBUG] mod_rayo.c:631 Unlock 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670: ref count = 1
2013-08-29 19:29:22.069305 [DEBUG] xmpp_streams.c:190 c2s_in 1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670 SEND <iq type='result' from='54.213.58.94' to='1@54.213.58.94/ip-172-31-41-127.us-west-2.compute.internal-2670' id='blather0018'/>
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment