Skip to content

Instantly share code, notes, and snippets.

@neerajnagi
Created March 3, 2014 22:15
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save neerajnagi/9335800 to your computer and use it in GitHub Desktop.
Save neerajnagi/9335800 to your computer and use it in GitHub Desktop.
<joined xmlns="urn:xmpp:rayo:1" call-uri="xmpp:32d2ea84-a321-11e3-92a8-af6f720258e8@176.9.89.23"/>
</presence>
[2014-03-03 23:14:43.550] DEBUG Adhearsion::OutboundCall: 32d2ea84-a321-11e3-92a8-af6f720258e8@176.9.89.23: Receiving message: #<Punchblock::Event:Joined target_call_id="32d2ea84-a321-11e3-92a8-af6f720258e8", target_mixer_name=nil, component_id=nil, source_uri="xmpp:32d2ea84-a321-11e3-92a8-a6f720258e8@176.9.89.23", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:14:43 +0100, call_uri="xmpp:dd2a3551-9e30-44f1-1eddb32afc293bd6@176.9.89.23", mixer_name=nil>
[2014-03-03 23:14:43.550] INFO Adhearsion::OutboundCall: 32d2ea84-a321-11e3-92a8-af6f720258e8@176.9.89.23: Joined to call xmpp:dd2a3551-9e30-44f11edd-b32afc293bd6@176.9.89.23
[2014-03-03 23:14:43.554] DEBUG Adhearsion::Call: dd2a3551-9e30-44f1-1edd-b32afc293bd6@176.9.89.23: Receiving message: #<Punchblock::Event::Joinedtarget_call_id="dd2a3551-9e30-44f1-1edd-b32afc293bd6", target_mixer_name=nil, component_id=nil, source_uri="xmpp:dd2a3551-9e30-44f1-1edd-b32afc293d6@176.9.89.23", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:14:43 +0100, call_uri="xmpp:32d2ea84-a321-11e3-92a8-af6f72058e8@176.9.89.23", mixer_name=nil>
[2014-03-03 23:14:43.554] INFO Adhearsion::Call: dd2a3551-9e30-44f1-1edd-b32afc293bd6@176.9.89.23: Joined to call xmpp:32d2ea84-a321-11e3-92a8-aff720258e8@176.9.89.23
[2014-03-03 23:14:45.239] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="1e67bc1e-a321-11e3-9243-af6f720258e8@176.9.89.2" to="1@176.9.89.23/voz.io-11369">
<unjoined xmlns="urn:xmpp:rayo:1" call-uri="xmpp:3c1370ff-27c5-c8fd-1c68-63bb0b7b5dd2@176.9.89.23"/>
</presence>
[2014-03-03 23:14:45.239] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="3c1370ff-27c5-c8fd-1c68-63bb0b7b5dd2@176.9.89.2" to="1@176.9.89.23/voz.io-11369">
<unjoined xmlns="urn:xmpp:rayo:1" call-uri="xmpp:1e67bc1e-a321-11e3-9243-af6f720258e8@176.9.89.23"/>
</presence>
[2014-03-03 23:14:45.242] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="3c1370ff-27c5-c8fd-1c68-63bb0b7b5dd2@176.9.89.2" to="1@176.9.89.23/voz.io-11369" type="unavailable">
<end xmlns="urn:xmpp:rayo:1">
<hungup platform-code="16"/>
<header name="X-route" value="DEFAULT"/>
</end>
</presence>
[2014-03-03 23:14:45.247] DEBUG Adhearsion::OutboundCall: 1e67bc1e-a321-11e3-9243-af6f720258e8@176.9.89.23: Receiving message: #<Punchblock::Event:Unjoined target_call_id="1e67bc1e-a321-11e3-9243-af6f720258e8", target_mixer_name=nil, component_id=nil, source_uri="xmpp:1e67bc1e-a321-11e3-9243af6f720258e8@176.9.89.23", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:14:45 +0100, call_uri="xmpp:3c1370ff-27c5-c8fd-1c8-63bb0b7b5dd2@176.9.89.23", mixer_name=nil>
[2014-03-03 23:14:45.248] INFO Adhearsion::OutboundCall: 1e67bc1e-a321-11e3-9243-af6f720258e8@176.9.89.23: Unjoined from call xmpp:3c1370ff-27c5-8fd-1c68-63bb0b7b5dd2@176.9.89.23
[2014-03-03 23:14:45.248] DEBUG Adhearsion::CallController::Dial::Dial: 9f3e4b33-a494-467d-98c1-e854edcdfe9b: Main calls were completed, waiting fr any added calls: [#<CountDownLatch:0x007f21186846e8 @count=0, @mutex=#<Mutex:0x007f21186846c0>, @conditional=#<ConditionVariable:0x007f211868464 @waiters={}, @waiters_mutex=#<Mutex:0x007f21186845d0>>>]
[2014-03-03 23:14:45.248] DEBUG Adhearsion::CallController::Dial::Dial: 9f3e4b33-a494-467d-98c1-e854edcdfe9b: All calls were completed, unblocking
[2014-03-03 23:14:45.251] DEBUG Adhearsion::Call: 3c1370ff-27c5-c8fd-1c68-63bb0b7b5dd2@176.9.89.23: Receiving message: #<Punchblock::Event::Unjoind target_call_id="3c1370ff-27c5-c8fd-1c68-63bb0b7b5dd2", target_mixer_name=nil, component_id=nil, source_uri="xmpp:3c1370ff-27c5-c8fd-1c68-63bb0b75dd2@176.9.89.23", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:14:45 +0100, call_uri="xmpp:1e67bc1e-a321-11e3-9243-af6f70258e8@176.9.89.23", mixer_name=nil>
[2014-03-03 23:14:45.250] INFO Adhearsion::CallController::Dial::Dial: 9f3e4b33-a494-467d-98c1-e854edcdfe9b: #dial finished. Hanging up 1 outboun calls which are still active: 1e67bc1e-a321-11e3-9243-af6f720258e8.
[2014-03-03 23:14:45.252] INFO Adhearsion::OutboundCall: 1e67bc1e-a321-11e3-9243-af6f720258e8@176.9.89.23: Hanging up
[2014-03-03 23:14:45.251] INFO Adhearsion::Call: 3c1370ff-27c5-c8fd-1c68-63bb0b7b5dd2@176.9.89.23: Unjoined from call xmpp:1e67bc1e-a321-11e3-924-af6f720258e8@176.9.89.23
[2014-03-03 23:14:45.253] DEBUG Adhearsion::OutboundCall: 1e67bc1e-a321-11e3-9243-af6f720258e8@176.9.89.23: Executing command #<Punchblock::Comman::Hangup target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:14:5 +0100, request_id="867ec574-7f9b-47dd-b02b-ff1fdb561735", headers={}>
[2014-03-03 23:14:45.254] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/lient.rb:149:in `write') <iq type="set" to="1e67bc1e-a321-11e3-9243-af6f720258e8@176.9.89.23" id="867ec574-7f9b-47dd-b02b-ff1fdb561735">
<hangup xmlns="urn:xmpp:rayo:1"/>
</iq>
[2014-03-03 23:14:45.256] DEBUG Adhearsion::Call: 3c1370ff-27c5-c8fd-1c68-63bb0b7b5dd2@176.9.89.23: Receiving message: #<Punchblock::Event::End taget_call_id="3c1370ff-27c5-c8fd-1c68-63bb0b7b5dd2", target_mixer_name=nil, component_id=nil, source_uri="xmpp:3c1370ff-27c5-c8fd-1c68-63bb0b7b5dd2176.9.89.23", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:14:45 +0100, headers={"X-route"=>"DEFAULT"}, reason=:hungup, patform_code="16">
[2014-03-03 23:14:45.256] INFO Adhearsion::Call: 3c1370ff-27c5-c8fd-1c68-63bb0b7b5dd2@176.9.89.23: Call ended due to hungup
[2014-03-03 23:14:45.257] INFO Adhearsion::CallController::Dial::Dial: 9f3e4b33-a494-467d-98c1-e854edcdfe9b: Root call ended, unblocking everythig...
[2014-03-03 23:14:45.276] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="1e67bc1e-a321-11e3-9243-af6f720258e8@176.9.89.23" to="1@1769.89.23/voz.io-11369" type="result" id="867ec574-7f9b-47dd-b02b-ff1fdb561735"/>
[2014-03-03 23:14:45.278] INFO Adhearsion::Call: 3c1370ff-27c5-c8fd-1c68-63bb0b7b5dd2@176.9.89.23: Call was hung up while executing a controller
[2014-03-03 23:14:45.279] INFO Adhearsion::Call: 3c1370ff-27c5-c8fd-1c68-63bb0b7b5dd2@176.9.89.23: after call reached ===============================================
[2014-03-03 23:14:45.315] DEBUG Adhearsion::Call: 3c1370ff-27c5-c8fd-1c68-63bb0b7b5dd2@176.9.89.23: Finished executing controller #<Incomming call3c1370ff-27c5-c8fd-1c68-63bb0b7b5dd2, metadata={}>
[2014-03-03 23:14:45.316] INFO Adhearsion::Router::Route: Call routing completed. Hanging up now...
[2014-03-03 23:14:45.316] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="1e67bc1e-a321-11e3-9243-af6f720258e8@176.9.89.2/record-2" to="1@176.9.89.23/voz.io-11369" type="unavailable">
<complete xmlns="urn:xmpp:rayo:ext:1">
<final-timeout xmlns="urn:xmpp:rayo:record:complete:1"/>
<recording xmlns="urn:xmpp:rayo:record:complete:1" uri="file:///usr/local/freeswitch/recordings/1e67bc1e-a321-11e3-9243-af6f720258e8-1.wav" duation="36759" size="0"/>
</complete>
</presence>
[2014-03-03 23:14:45.317] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="1e67bc1e-a321-11e3-9243-af6f720258e8@176.9.89.2" to="1@176.9.89.23/voz.io-11369" type="unavailable">
<end xmlns="urn:xmpp:rayo:1">
<hangup-command/>
</end>
</presence>
[2014-03-03 23:14:45.326] INFO Adhearsion::OutboundCall: 1e67bc1e-a321-11e3-9243-af6f720258e8@176.9.89.23: Async recording for call id 3c1370ff-2c5-c8fd-1c68-63bb0b7b5dd2 saved to file:///usr/local/freeswitch/recordings/1e67bc1e-a321-11e3-9243-af6f720258e8-1.wav
/usr/bin/sox effects: rate clipped 6 samples; decrease volume?
[2014-03-03 23:14:53.112] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.2" to="1@176.9.89.23/voz.io-11369">
<c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="urn:xmpp:rayo:call:1" ver="L9rOKMEJl9rssEggArljiapRd9k="/>
<offer xmlns="urn:xmpp:rayo:1" from="sip:test7@176.9.89.23" to="sip:+525556607221@176.9.89.23">
<header name="from" value="&lt;sip:test7@176.9.89.23&gt;;tag=QtVAyKO7kZun5hqeNaff"/>
<header name="to" value="&lt;sip:+525556607221@176.9.89.23&gt;"/>
<header name="via" value="SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKEMPIIsmdQaQeQEBGI0NwbQhyuZ8E9bcD;rport=59343;received=202.157.93.2"/>
<header name="X-route" value="DEFAULT"/>
</offer>
</presence>
[2014-03-03 23:14:54.643] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.2" to="1@176.9.89.23/voz.io-11369">
<c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="urn:xmpp:rayo:call:1" ver="L9rOKMEJl9rssEggArljiapRd9k="/>
<offer xmlns="urn:xmpp:rayo:1" from="sip:test6@176.9.89.23" to="sip:+525552844000@176.9.89.23">
<header name="from" value="&lt;sip:test6@176.9.89.23&gt;;tag=4p2C2rI2SdS6t3SdNqwO"/>
<header name="to" value="&lt;sip:+525552844000@176.9.89.23&gt;"/>
<header name="via" value="SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKGGPaHo3R2NPK9WmmK7I2krqb4fUhQCfb;rport=59344;received=202.157.93.2"/>
<header name="X-route" value="DEFAULT"/>
</offer>
</presence>
[2014-03-03 23:14:56.637] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.2" to="1@176.9.89.23/voz.io-11369">
<c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="urn:xmpp:rayo:call:1" ver="L9rOKMEJl9rssEggArljiapRd9k="/>
<offer xmlns="urn:xmpp:rayo:1" from="sip:test5@176.9.89.23" to="sip:+525516656616@176.9.89.23">
<header name="from" value="&lt;sip:test5@176.9.89.23&gt;;tag=B5ndK9479BDlQ5KRxgBU"/>
<header name="to" value="&lt;sip:+525516656616@176.9.89.23&gt;"/>
<header name="via" value="SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKlkfR40XMuuGHzbrkln7OgnaFpQ9ycUMv;rport=59345;received=202.157.93.2"/>
<header name="X-route" value="DEFAULT"/>
</offer>
</presence>
[2014-03-03 23:14:56.778] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="d8da36d7-0e96-5bb7-d949-61a43598e920@176.9.89.2" to="1@176.9.89.23/voz.io-11369">
<c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="urn:xmpp:rayo:call:1" ver="L9rOKMEJl9rssEggArljiapRd9k="/>
<offer xmlns="urn:xmpp:rayo:1" from="sip:sergi.almar_gmail.com@176.9.89.23" to="sip:+34672172836@176.9.89.23">
<header name="from" value="&quot;Sergi&quot; &lt;sip:sergi.almar_gmail.com@176.9.89.23&gt;;tag=cPw9pLn7XMkqRIpWEo81"/>
<header name="to" value="&lt;sip:+34672172836@176.9.89.23&gt;"/>
<header name="via" value="SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKKWVvwugtCSyDgs5A4pttzpAp2DyvOg6O;rport=61568;received=92.59.0.106"/>
<header name="X-route" value="DEFAULT"/>
</offer>
</presence>
[2014-03-03 23:14:58.348] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="ec6f1b66-3fdf-a913-5fbf-2474bab4fc12@176.9.89.2" to="1@176.9.89.23/voz.io-11369">
<unjoined xmlns="urn:xmpp:rayo:1" call-uri="xmpp:03dd6736-a321-11e3-91b1-af6f720258e8@176.9.89.23"/>
</presence>
[2014-03-03 23:14:58.349] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="03dd6736-a321-11e3-91b1-af6f720258e8@176.9.89.2/record-2" to="1@176.9.89.23/voz.io-11369" type="unavailable">
<complete xmlns="urn:xmpp:rayo:ext:1">
<final-timeout xmlns="urn:xmpp:rayo:record:complete:1"/>
<recording xmlns="urn:xmpp:rayo:record:complete:1" uri="file:///usr/local/freeswitch/recordings/03dd6736-a321-11e3-91b1-af6f720258e8-1.wav" duation="96240" size="0"/>
</complete>
</presence>
[2014-03-03 23:14:58.368] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="03dd6736-a321-11e3-91b1-af6f720258e8@176.9.89.2" to="1@176.9.89.23/voz.io-11369">
<unjoined xmlns="urn:xmpp:rayo:1" call-uri="xmpp:ec6f1b66-3fdf-a913-5fbf-2474bab4fc12@176.9.89.23"/>
</presence>
[2014-03-03 23:14:58.369] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="03dd6736-a321-11e3-91b1-af6f720258e8@176.9.89.2" to="1@176.9.89.23/voz.io-11369" type="unavailable">
<end xmlns="urn:xmpp:rayo:1">
<hungup platform-code="16"/>
</end>
</presence>
[2014-03-03 23:14:58.372] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="db1d244c-b864-43a2-30c7-ff7041ea5ecb@176.9.89.2" to="1@176.9.89.23/voz.io-11369">
<c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="urn:xmpp:rayo:call:1" ver="L9rOKMEJl9rssEggArljiapRd9k="/>
<offer xmlns="urn:xmpp:rayo:1" from="sip:test4@176.9.89.23" to="sip:+529999261077@176.9.89.23">
<header name="from" value="&lt;sip:test4@176.9.89.23&gt;;tag=LgRLZJtuIHV8k6qT8l8h"/>
<header name="to" value="&lt;sip:+529999261077@176.9.89.23&gt;"/>
<header name="via" value="SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKP6CxO22JGTCrkKytByHkNC5RG7JIuTnu;rport=59346;received=202.157.93.2"/>
<header name="X-route" value="DEFAULT"/>
</offer>
</presence>
[2014-03-03 23:15:00.202] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="b30057e9-5cef-0fc5-5fdb-ffee381bef0b@176.9.89.2" to="1@176.9.89.23/voz.io-11369">
<c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="urn:xmpp:rayo:call:1" ver="L9rOKMEJl9rssEggArljiapRd9k="/>
<offer xmlns="urn:xmpp:rayo:1" from="sip:test3@176.9.89.23" to="sip:+529992547785@176.9.89.23">
<header name="from" value="&lt;sip:test3@176.9.89.23&gt;;tag=OuLnXCHto297xXHFkPmb"/>
<header name="to" value="&lt;sip:+529992547785@176.9.89.23&gt;"/>
<header name="via" value="SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKKDLArzwk69Ju5ewW9Tpe9oq6zffHkTMJ;rport=59347;received=202.157.93.2"/>
<header name="X-route" value="DEFAULT"/>
</offer>
</presence>
[2014-03-03 23:15:01.712] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="d266d18e-e095-4822-fbc3-99a56f5072bc@176.9.89.2" to="1@176.9.89.23/voz.io-11369">
<c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="urn:xmpp:rayo:call:1" ver="L9rOKMEJl9rssEggArljiapRd9k="/>
<offer xmlns="urn:xmpp:rayo:1" from="sip:pedro.sarabia_web93.mx@176.9.89.23" to="sip:+529999483477@176.9.89.23">
<header name="from" value="&quot;Pedro&quot; &lt;sip:pedro.sarabia_web93.mx@176.9.89.23&gt;;tag=2DVAW2Wk7xdpQ55mHxzb"/>
<header name="to" value="&lt;sip:+529999483477@176.9.89.23&gt;"/>
<header name="via" value="SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKx0hbqcGM7GLJW96Cqkv9p6eUV0kTEnyl;rport=41302;received=187.147.142.169">
<header name="X-route" value="DEFAULT"/>
</offer>
</presence>
[2014-03-03 23:15:01.713] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="ec6f1b66-3fdf-a913-5fbf-2474bab4fc12@176.9.89.2" to="1@176.9.89.23/voz.io-11369" type="unavailable">
<end xmlns="urn:xmpp:rayo:1">
<hungup platform-code="16"/>
<header name="X-route" value="DEFAULT"/>
</end>
</presence>
[2014-03-03 23:15:02.437] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="50ad98f4-7383-f8bd-3290-bcb9aeecfbee@176.9.89.2" to="1@176.9.89.23/voz.io-11369">
<c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="urn:xmpp:rayo:call:1" ver="L9rOKMEJl9rssEggArljiapRd9k="/>
<offer xmlns="urn:xmpp:rayo:1" from="sip:test2@176.9.89.23" to="sip:+525555535570@176.9.89.23">
<header name="from" value="&lt;sip:test2@176.9.89.23&gt;;tag=dbSfxNK533ANQisAPVZh"/>
<header name="to" value="&lt;sip:+525555535570@176.9.89.23&gt;"/>
<header name="via" value="SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKR5GaKQqz6WqzDR9ChzF1SKg65bzhisgh;rport=59348;received=202.157.93.2"/>
<header name="X-route" value="DEFAULT"/>
</offer>
</presence>
AHN> [2014-03-03 23:15:06.964] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="d8da36d7-0e96-5bb7-d949-61a43598e920@176.9.89.23" to="1@176.9.89.23/voz.io-11369" type="unavailable">
<end xmlns="urn:xmpp:rayo:1">
<hungup platform-code="16"/>
<header name="X-route" value="DEFAULT"/>
</end>
</presence>
[2014-03-03 23:15:07.481] INFO ConfirmationController: posted data to update_call{"call_id"=>"7447abd5-993e-522b-1469-0e124006d5e0", "file_path"=>"https://s3-us-west-2.amazonaws.com/letmecallu-recordings/7447abd5-993e-522b-1469-0e124006d5e0.wav", "controller"=>"api", "action"=>"api_post", "type"=>"update_calls"}
[2014-03-03 23:15:07.483] WARN Adhearsion::PunchblockPlugin::Initializer: Event received for inactive call 115cfdfe-a321-11e3-91dd-af6f720258e8: #<Punchblock::Event::Complete target_call_id="115cfdfe-a321-11e3-91dd-af6f720258e8", target_mixer_name=nil, component_id="record-2", source_uri="xmpp:115cfdfe-a321-11e3-91dd-af6f720258e8@176.9.89.23/record-2", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:13:48 +0100, reason=#<Punchblock::Component::Record::Complete::FinalTimeout target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:13:48 +0100, name=:"final-timeout">, recording=#<Punchblock::Component::Record::Recording target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:13:48 +0100, uri="file:///usr/local/freeswitch/recordings/115cfdfe-a321-11e3-91dd-af6f720258e8-1.wav", duration=4539, size=0>, fax=nil, fax_metadata={}>
[2014-03-03 23:15:07.485] DEBUG Adhearsion::OutboundCall: 1e67bc1e-a321-11e3-9243-af6f720258e8@176.9.89.23: Receiving message: #<Punchblock::Event::End target_call_id="1e67bc1e-a321-11e3-9243-af6f720258e8", target_mixer_name=nil, component_id=nil, source_uri="xmpp:1e67bc1e-a321-11e3-9243-af6f720258e8@176.9.89.23", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:14:45 +0100, headers={}, reason=:"hangup-command", platform_code=nil>
[2014-03-03 23:15:07.485] INFO Adhearsion::OutboundCall: 1e67bc1e-a321-11e3-9243-af6f720258e8@176.9.89.23: Call ended due to hangup-command
[2014-03-03 23:15:07.489] DEBUG Adhearsion::Call: @: Receiving message: #<Punchblock::Event::Offer target_call_id="73048c88-15f7-a077-c36c-44823faf3b2a", target_mixer_name=nil, component_id=nil, source_uri="xmpp:73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:14:53 +0100, headers={"from"=>"<sip:test7@176.9.89.23>;tag=QtVAyKO7kZun5hqeNaff", "to"=>"<sip:+525556607221@176.9.89.23>", "via"=>"SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKEMPIIsmdQaQeQEBGI0NwbQhyuZ8E9bcD;rport=59343;received=202.157.93.2", "X-route"=>"DEFAULT"}, to="sip:+525556607221@176.9.89.23", from="sip:test7@176.9.89.23">
[2014-03-03 23:15:07.492] INFO Adhearsion::Router: Call 73048c88-15f7-a077-c36c-44823faf3b2a selected route "default" (Incomming)
[2014-03-03 23:15:07.529] DEBUG Adhearsion::Call: 73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23: Executing command #<Punchblock::Command::Accept target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:07 +0100, request_id="9400e7bc-408b-4c45-a0b5-c99af58a7e73", headers={}>
[2014-03-03 23:15:07.530] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23" id="9400e7bc-408b-4c45-a0b5-c99af58a7e73">
<accept xmlns="urn:xmpp:rayo:1"/>
</iq>
[2014-03-03 23:15:07.652] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23" to="1@176.9.89.23/voz.io-11369" type="result" id="9400e7bc-408b-4c45-a0b5-c99af58a7e73"/>
[2014-03-03 23:15:07.654] INFO Adhearsion::Call: 73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23: Executing controller #<Incomming call=73048c88-15f7-a077-c36c-44823faf3b2a, metadata={}>
[2014-03-03 23:15:07.656] DEBUG Adhearsion::Call: 73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23: Receiving message: #<Punchblock::Event::Offer target_call_id="73048c88-15f7-a077-c36c-44823faf3b2a", target_mixer_name=nil, component_id=nil, source_uri="xmpp:73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:14:53 +0100, headers={"from"=>"<sip:test7@176.9.89.23>;tag=QtVAyKO7kZun5hqeNaff", "to"=>"<sip:+525556607221@176.9.89.23>", "via"=>"SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKEMPIIsmdQaQeQEBGI0NwbQhyuZ8E9bcD;rport=59343;received=202.157.93.2", "X-route"=>"DEFAULT"}, to="sip:+525556607221@176.9.89.23", from="sip:test7@176.9.89.23">
[2014-03-03 23:15:07.658] DEBUG Adhearsion::Call: 73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23: Executing command #<Punchblock::Command::Answer target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:07 +0100, request_id="dced03c0-ddfa-4039-b915-5a1c113f6414", headers={}>
[2014-03-03 23:15:07.659] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23" id="dced03c0-ddfa-4039-b915-5a1c113f6414">
<answer xmlns="urn:xmpp:rayo:1"/>
</iq>
[2014-03-03 23:15:07.661] DEBUG Adhearsion::Call: @: Receiving message: #<Punchblock::Event::Offer target_call_id="b56053f9-f20c-0b70-449e-d8460d2d3d56", target_mixer_name=nil, component_id=nil, source_uri="xmpp:b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:14:54 +0100, headers={"from"=>"<sip:test6@176.9.89.23>;tag=4p2C2rI2SdS6t3SdNqwO", "to"=>"<sip:+525552844000@176.9.89.23>", "via"=>"SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKGGPaHo3R2NPK9WmmK7I2krqb4fUhQCfb;rport=59344;received=202.157.93.2", "X-route"=>"DEFAULT"}, to="sip:+525552844000@176.9.89.23", from="sip:test6@176.9.89.23">
[2014-03-03 23:15:07.663] INFO Adhearsion::Router: Call b56053f9-f20c-0b70-449e-d8460d2d3d56 selected route "default" (Incomming)
[2014-03-03 23:15:07.666] DEBUG Adhearsion::Call: b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23: Executing command #<Punchblock::Command::Accept target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:07 +0100, request_id="c1438daa-efbe-4e70-9bd9-50539b414a7e", headers={}>
[2014-03-03 23:15:07.667] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23" id="c1438daa-efbe-4e70-9bd9-50539b414a7e">
<accept xmlns="urn:xmpp:rayo:1"/>
</iq>
[2014-03-03 23:15:07.668] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23" to="1@176.9.89.23/voz.io-11369">
<answered xmlns="urn:xmpp:rayo:1"/>
</presence>
[2014-03-03 23:15:07.708] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23" to="1@176.9.89.23/voz.io-11369" type="result" id="dced03c0-ddfa-4039-b915-5a1c113f6414"/>
[2014-03-03 23:15:07.711] INFO Adhearsion::Call: 73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23: call metadata is {"from"=>"<sip:test7@176.9.89.23>;tag=QtVAyKO7kZun5hqeNaff", "to"=>"<sip:+525556607221@176.9.89.23>", "via"=>"SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKEMPIIsmdQaQeQEBGI0NwbQhyuZ8E9bcD;rport=59343;received=202.157.93.2", "x_route"=>"DEFAULT"}
[2014-03-03 23:15:07.711] INFO Adhearsion::Call: 73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23: test7 -------------------------------> +525556607221
[2014-03-03 23:15:07.712] INFO Adhearsion::Call: 73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23: sip agent is --------------- Vox
[2014-03-03 23:15:07.713] INFO Adhearsion::Call: 73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23: call from Vox agent
[2014-03-03 23:15:07.714] INFO Adhearsion::Call: 73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23: original called id is test7
[2014-03-03 23:15:07.789] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23" to="1@176.9.89.23/voz.io-11369" type="result" id="c1438daa-efbe-4e70-9bd9-50539b414a7e"/>
[2014-03-03 23:15:07.790] INFO Adhearsion::Call: b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23: Executing controller #<Incomming call=b56053f9-f20c-0b70-449e-d8460d2d3d56, metadata={}>
[2014-03-03 23:15:07.793] DEBUG Adhearsion::Call: b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23: Receiving message: #<Punchblock::Event::Offer target_call_id="b56053f9-f20c-0b70-449e-d8460d2d3d56", target_mixer_name=nil, component_id=nil, source_uri="xmpp:b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:14:54 +0100, headers={"from"=>"<sip:test6@176.9.89.23>;tag=4p2C2rI2SdS6t3SdNqwO", "to"=>"<sip:+525552844000@176.9.89.23>", "via"=>"SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKGGPaHo3R2NPK9WmmK7I2krqb4fUhQCfb;rport=59344;received=202.157.93.2", "X-route"=>"DEFAULT"}, to="sip:+525552844000@176.9.89.23", from="sip:test6@176.9.89.23">
[2014-03-03 23:15:07.795] DEBUG Adhearsion::Call: b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23: Executing command #<Punchblock::Command::Answer target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:07 +0100, request_id="239435f2-deae-4e65-843a-0357b287f662", headers={}>
[2014-03-03 23:15:07.795] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23" id="239435f2-deae-4e65-843a-0357b287f662">
<answer xmlns="urn:xmpp:rayo:1"/>
</iq>
[2014-03-03 23:15:07.798] DEBUG Adhearsion::Call: @: Receiving message: #<Punchblock::Event::Offer target_call_id="836afc87-9ffc-8ba0-18af-6d14c7179f24", target_mixer_name=nil, component_id=nil, source_uri="xmpp:836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:14:56 +0100, headers={"from"=>"<sip:test5@176.9.89.23>;tag=B5ndK9479BDlQ5KRxgBU", "to"=>"<sip:+525516656616@176.9.89.23>", "via"=>"SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKlkfR40XMuuGHzbrkln7OgnaFpQ9ycUMv;rport=59345;received=202.157.93.2", "X-route"=>"DEFAULT"}, to="sip:+525516656616@176.9.89.23", from="sip:test5@176.9.89.23">
[2014-03-03 23:15:07.800] INFO Adhearsion::Router: Call 836afc87-9ffc-8ba0-18af-6d14c7179f24 selected route "default" (Incomming)
[2014-03-03 23:15:07.803] DEBUG Adhearsion::Call: 836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23: Executing command #<Punchblock::Command::Accept target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:07 +0100, request_id="5223622b-bf68-4685-a9e0-e446813ca2ce", headers={}>
[2014-03-03 23:15:07.804] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23" id="5223622b-bf68-4685-a9e0-e446813ca2ce">
<accept xmlns="urn:xmpp:rayo:1"/>
</iq>
[2014-03-03 23:15:07.805] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23" to="1@176.9.89.23/voz.io-11369">
<answered xmlns="urn:xmpp:rayo:1"/>
</presence>
[2014-03-03 23:15:07.845] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23" to="1@176.9.89.23/voz.io-11369" type="result" id="239435f2-deae-4e65-843a-0357b287f662"/>
[2014-03-03 23:15:07.884] INFO Adhearsion::Call: b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23: call metadata is {"from"=>"<sip:test6@176.9.89.23>;tag=4p2C2rI2SdS6t3SdNqwO", "to"=>"<sip:+525552844000@176.9.89.23>", "via"=>"SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKGGPaHo3R2NPK9WmmK7I2krqb4fUhQCfb;rport=59344;received=202.157.93.2", "x_route"=>"DEFAULT"}
[2014-03-03 23:15:07.884] INFO Adhearsion::Call: b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23: test6 -------------------------------> +525552844000
[2014-03-03 23:15:07.884] INFO Adhearsion::Call: b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23: sip agent is --------------- Vox
[2014-03-03 23:15:07.885] INFO Adhearsion::Call: b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23: call from Vox agent
[2014-03-03 23:15:07.885] INFO Adhearsion::Call: b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23: original called id is test6
[2014-03-03 23:15:07.926] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23" to="1@176.9.89.23/voz.io-11369" type="result" id="5223622b-bf68-4685-a9e0-e446813ca2ce"/>
[2014-03-03 23:15:07.927] INFO Adhearsion::Call: 836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23: Executing controller #<Incomming call=836afc87-9ffc-8ba0-18af-6d14c7179f24, metadata={}>
[2014-03-03 23:15:07.929] DEBUG Adhearsion::Call: 836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23: Executing command #<Punchblock::Command::Answer target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:07 +0100, request_id="c22204bc-aa4f-4038-a7d4-91decdd2dfa7", headers={}>
[2014-03-03 23:15:07.930] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23" id="c22204bc-aa4f-4038-a7d4-91decdd2dfa7">
<answer xmlns="urn:xmpp:rayo:1"/>
</iq>
[2014-03-03 23:15:07.931] DEBUG Adhearsion::Call: 836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23: Receiving message: #<Punchblock::Event::Offer target_call_id="836afc87-9ffc-8ba0-18af-6d14c7179f24", target_mixer_name=nil, component_id=nil, source_uri="xmpp:836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:14:56 +0100, headers={"from"=>"<sip:test5@176.9.89.23>;tag=B5ndK9479BDlQ5KRxgBU", "to"=>"<sip:+525516656616@176.9.89.23>", "via"=>"SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKlkfR40XMuuGHzbrkln7OgnaFpQ9ycUMv;rport=59345;received=202.157.93.2", "X-route"=>"DEFAULT"}, to="sip:+525516656616@176.9.89.23", from="sip:test5@176.9.89.23">
[2014-03-03 23:15:07.932] DEBUG Adhearsion::Call: @: Receiving message: #<Punchblock::Event::Offer target_call_id="d8da36d7-0e96-5bb7-d949-61a43598e920", target_mixer_name=nil, component_id=nil, source_uri="xmpp:d8da36d7-0e96-5bb7-d949-61a43598e920@176.9.89.23", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:14:56 +0100, headers={"from"=>"\"Sergi\" <sip:sergi.almar_gmail.com@176.9.89.23>;tag=cPw9pLn7XMkqRIpWEo81", "to"=>"<sip:+34672172836@176.9.89.23>", "via"=>"SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKKWVvwugtCSyDgs5A4pttzpAp2DyvOg6O;rport=61568;received=92.59.0.106", "X-route"=>"DEFAULT"}, to="sip:+34672172836@176.9.89.23", from="sip:sergi.almar_gmail.com@176.9.89.23">
[2014-03-03 23:15:07.934] INFO Adhearsion::Router: Call d8da36d7-0e96-5bb7-d949-61a43598e920 selected route "default" (Incomming)
[2014-03-03 23:15:07.936] DEBUG Adhearsion::Call: d8da36d7-0e96-5bb7-d949-61a43598e920@176.9.89.23: Executing command #<Punchblock::Command::Accept target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:07 +0100, request_id="5c56d4f2-2a09-4944-961d-89b2c1b9c48a", headers={}>
[2014-03-03 23:15:07.937] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="d8da36d7-0e96-5bb7-d949-61a43598e920@176.9.89.23" id="5c56d4f2-2a09-4944-961d-89b2c1b9c48a">
<accept xmlns="urn:xmpp:rayo:1"/>
</iq>
[2014-03-03 23:15:07.938] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23" to="1@176.9.89.23/voz.io-11369">
<answered xmlns="urn:xmpp:rayo:1"/>
</presence>
[2014-03-03 23:15:07.977] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23" to="1@176.9.89.23/voz.io-11369" type="result" id="c22204bc-aa4f-4038-a7d4-91decdd2dfa7"/>
[2014-03-03 23:15:07.978] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq type="error" to="1@176.9.89.23/voz.io-11369" id="5c56d4f2-2a09-4944-961d-89b2c1b9c48a" from="d8da36d7-0e96-5bb7-d949-61a43598e920@176.9.89.23">
<accept xmlns="urn:xmpp:rayo:1"/>
<error type="cancel">
<item-not-found xmlns="urn:ietf:params:xml:ns:xmpp-stanzas"/>
</error>
</iq>
[2014-03-03 23:15:07.981] DEBUG Adhearsion::Call: d8da36d7-0e96-5bb7-d949-61a43598e920@176.9.89.23: Receiving message: #<Punchblock::Event::Offer target_call_id="d8da36d7-0e96-5bb7-d949-61a43598e920", target_mixer_name=nil, component_id=nil, source_uri="xmpp:d8da36d7-0e96-5bb7-d949-61a43598e920@176.9.89.23", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:14:56 +0100, headers={"from"=>"\"Sergi\" <sip:sergi.almar_gmail.com@176.9.89.23>;tag=cPw9pLn7XMkqRIpWEo81", "to"=>"<sip:+34672172836@176.9.89.23>", "via"=>"SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKKWVvwugtCSyDgs5A4pttzpAp2DyvOg6O;rport=61568;received=92.59.0.106", "X-route"=>"DEFAULT"}, to="sip:+34672172836@176.9.89.23", from="sip:sergi.almar_gmail.com@176.9.89.23">
[2014-03-03 23:15:07.983] DEBUG Adhearsion::Call: ec6f1b66-3fdf-a913-5fbf-2474bab4fc12@176.9.89.23: Receiving message: #<Punchblock::Event::Unjoined target_call_id="ec6f1b66-3fdf-a913-5fbf-2474bab4fc12", target_mixer_name=nil, component_id=nil, source_uri="xmpp:ec6f1b66-3fdf-a913-5fbf-2474bab4fc12@176.9.89.23", domain="176.9.89.23", transport="xmpp", timestamp=Mon, 03 Mar 2014 23:14:58 +0100, call_uri="xmpp:03dd6736-a321-11e3-91b1-af6f720258e8@176.9.89.23", mixer_name=nil>
[2014-03-03 23:15:07.983] INFO Adhearsion::Call: ec6f1b66-3fdf-a913-5fbf-2474bab4fc12@176.9.89.23: Unjoined from call xmpp:03dd6736-a321-11e3-91b1-af6f720258e8@176.9.89.23
[2014-03-03 23:15:07.984] INFO Adhearsion::OutboundCall: 03dd6736-a321-11e3-91b1-af6f720258e8@176.9.89.23: Async recording for call id ec6f1b66-3fdf-a913-5fbf-2474bab4fc12 saved to file:///usr/local/freeswitch/recordings/03dd6736-a321-11e3-91b1-af6f720258e8-1.wav
[2014-03-03 23:15:07.991] INFO Adhearsion::Call: 836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23: call metadata is {"from"=>"<sip:test5@176.9.89.23>;tag=B5ndK9479BDlQ5KRxgBU", "to"=>"<sip:+525516656616@176.9.89.23>", "via"=>"SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKlkfR40XMuuGHzbrkln7OgnaFpQ9ycUMv;rport=59345;received=202.157.93.2", "x_route"=>"DEFAULT"}
[2014-03-03 23:15:07.991] INFO Adhearsion::Call: 836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23: test5 -------------------------------> +525516656616
[2014-03-03 23:15:07.991] INFO Adhearsion::Call: 836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23: sip agent is --------------- Vox
[2014-03-03 23:15:07.993] INFO Adhearsion::Call: 836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23: call from Vox agent
[2014-03-03 23:15:07.993] INFO Adhearsion::Call: 836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23: original called id is test5
[2014-03-03 23:15:08.315] INFO Adhearsion::Call: 73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23: updated caller id is test7
[2014-03-03 23:15:08.317] DEBUG Adhearsion::Call: 73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23: Executing command #<Punchblock::Command::Answer target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:08 +0100, request_id="5e699772-083e-4d05-8f52-9a0b923784b6", headers={}>
[2014-03-03 23:15:08.318] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23" id="5e699772-083e-4d05-8f52-9a0b923784b6">
<answer xmlns="urn:xmpp:rayo:1"/>
</iq>
[2014-03-03 23:15:08.339] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23" to="1@176.9.89.23/voz.io-11369" type="result" id="5e699772-083e-4d05-8f52-9a0b923784b6"/>
[2014-03-03 23:15:08.344] DEBUG Adhearsion::Call: 73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23: Executing command #<Punchblock::Component::Output target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:08 +0100, request_id="ec7c5923-17d5-40f1-a6b9-d5ed1be4e5b8", voice=nil, interrupt_on=nil, start_offset=nil, start_paused=nil, repeat_interval=nil, repeat_times=0, max_time=nil, renderer=nil, render_documents=[#<Punchblock::Component::Output::Document target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:08 +0100, 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/system/ringback.wav"/>
</speak>>]>
[2014-03-03 23:15:08.345] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23" id="ec7c5923-17d5-40f1-a6b9-d5ed1be4e5b8">
<output xmlns="urn:xmpp:rayo:output:1" repeat-times="0">
<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/system/ringback.wav"/>
</speak>]]></document>
</output>
</iq>
[2014-03-03 23:15:08.365] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23" to="1@176.9.89.23/voz.io-11369" type="result" id="ec7c5923-17d5-40f1-a6b9-d5ed1be4e5b8">
<ref xmlns="urn:xmpp:rayo:1" uri="xmpp:73048c88-15f7-a077-c36c-44823faf3b2a@176.9.89.23/output-1"/>
</iq>
[2014-03-03 23:15:08.369] DEBUG Adhearsion::OutboundCall: @: Executing command #<Punchblock::Command::Dial target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:08 +0100, request_id="1a874fec-4455-45af-9f67-29fd60d701ff", headers={}, to="sofia/external/525556607221@sbc.voxbeam.com", from="test7", uri=nil, timeout=nil, join=nil>
[2014-03-03 23:15:08.369] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="176.9.89.23" id="1a874fec-4455-45af-9f67-29fd60d701ff">
<dial xmlns="urn:xmpp:rayo:1" to="sofia/external/525556607221@sbc.voxbeam.com" from="test7"/>
</iq>
[2014-03-03 23:15:08.382] INFO Adhearsion::Call: b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23: updated caller id is test6
[2014-03-03 23:15:08.383] DEBUG Adhearsion::Call: b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23: Executing command #<Punchblock::Command::Answer target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:08 +0100, request_id="31918b84-b1aa-4814-a4b8-46eaa29bc506", headers={}>
[2014-03-03 23:15:08.383] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23" id="31918b84-b1aa-4814-a4b8-46eaa29bc506">
<answer xmlns="urn:xmpp:rayo:1"/>
</iq>
[2014-03-03 23:15:08.404] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23" to="1@176.9.89.23/voz.io-11369" type="result" id="31918b84-b1aa-4814-a4b8-46eaa29bc506"/>
[2014-03-03 23:15:08.441] DEBUG Adhearsion::Call: b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23: Executing command #<Punchblock::Component::Output target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:08 +0100, request_id="8ff91374-cf1f-498e-bff0-45e79b928630", voice=nil, interrupt_on=nil, start_offset=nil, start_paused=nil, repeat_interval=nil, repeat_times=0, max_time=nil, renderer=nil, render_documents=[#<Punchblock::Component::Output::Document target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:08 +0100, 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/system/ringback.wav"/>
</speak>>]>
[2014-03-03 23:15:08.441] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23" id="8ff91374-cf1f-498e-bff0-45e79b928630">
<output xmlns="urn:xmpp:rayo:output:1" repeat-times="0">
<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/system/ringback.wav"/>
</speak>]]></document>
</output>
</iq>
[2014-03-03 23:15:08.462] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23" to="1@176.9.89.23/voz.io-11369" type="result" id="8ff91374-cf1f-498e-bff0-45e79b928630">
<ref xmlns="urn:xmpp:rayo:1" uri="xmpp:b56053f9-f20c-0b70-449e-d8460d2d3d56@176.9.89.23/output-1"/>
</iq>
[2014-03-03 23:15:08.467] DEBUG Adhearsion::OutboundCall: @: Executing command #<Punchblock::Command::Dial target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:08 +0100, request_id="995bc4e3-9c55-40d8-874b-46af79c0b22a", headers={}, to="sofia/external/525552844000@sbc.voxbeam.com", from="test6", uri=nil, timeout=nil, join=nil>
[2014-03-03 23:15:08.468] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="176.9.89.23" id="995bc4e3-9c55-40d8-874b-46af79c0b22a">
<dial xmlns="urn:xmpp:rayo:1" to="sofia/external/525552844000@sbc.voxbeam.com" from="test6"/>
</iq>
[2014-03-03 23:15:08.488] INFO Adhearsion::Call: 836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23: updated caller id is test5
[2014-03-03 23:15:08.490] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="176.9.89.23" to="1@176.9.89.23/voz.io-11369" id="1a874fec-4455-45af-9f67-29fd60d701ff" type="result">
<ref xmlns="urn:xmpp:rayo:1" uri="xmpp:47b77e74-a321-11e3-92e6-af6f720258e8@176.9.89.23"/>
</iq>
[2014-03-03 23:15:08.489] DEBUG Adhearsion::Call: 836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23: Executing command #<Punchblock::Command::Answer target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:08 +0100, request_id="73e7c267-805a-489c-8359-857f9cb9add5", headers={}>
[2014-03-03 23:15:08.491] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23" id="73e7c267-805a-489c-8359-857f9cb9add5">
<answer xmlns="urn:xmpp:rayo:1"/>
</iq>
[2014-03-03 23:15:08.494] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23" to="1@176.9.89.23/voz.io-11369" type="result" id="73e7c267-805a-489c-8359-857f9cb9add5"/>
[2014-03-03 23:15:08.504] DEBUG Adhearsion::Call: 836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23: Executing command #<Punchblock::Component::Output target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:08 +0100, request_id="115e597c-f9d9-4eda-bf31-6ec35c238e42", voice=nil, interrupt_on=nil, start_offset=nil, start_paused=nil, repeat_interval=nil, repeat_times=0, max_time=nil, renderer=nil, render_documents=[#<Punchblock::Component::Output::Document target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:08 +0100, 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/system/ringback.wav"/>
</speak>>]>
[2014-03-03 23:15:08.505] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23" id="115e597c-f9d9-4eda-bf31-6ec35c238e42">
<output xmlns="urn:xmpp:rayo:output:1" repeat-times="0">
<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/system/ringback.wav"/>
</speak>]]></document>
</output>
</iq>
[2014-03-03 23:15:08.526] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23" to="1@176.9.89.23/voz.io-11369" type="result" id="115e597c-f9d9-4eda-bf31-6ec35c238e42">
<ref xmlns="urn:xmpp:rayo:1" uri="xmpp:836afc87-9ffc-8ba0-18af-6d14c7179f24@176.9.89.23/output-1"/>
</iq>
[2014-03-03 23:15:08.532] DEBUG Adhearsion::OutboundCall: @: Executing command #<Punchblock::Command::Dial target_call_id=nil, target_mixer_name=nil, component_id=nil, source_uri=nil, domain=nil, transport=nil, timestamp=Mon, 03 Mar 2014 23:15:08 +0100, request_id="8a2a3916-051c-433e-a160-516c255ea17c", headers={}, to="sofia/external/525516656616@sbc.voxbeam.com", from="test5", uri=nil, timeout=nil, join=nil>
[2014-03-03 23:15:08.533] TRACE Punchblock::Connection::XMPP: SENDING: (/usr/local/rvm/gems/ruby-2.0.0-p247/gems/blather-1.0.0/lib/blather/client/client.rb:149:in `write') <iq type="set" to="176.9.89.23" id="8a2a3916-051c-433e-a160-516c255ea17c">
<dial xmlns="urn:xmpp:rayo:1" to="sofia/external/525516656616@sbc.voxbeam.com" from="test5"/>
</iq>
[2014-03-03 23:15:08.594] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq from="176.9.89.23" to="1@176.9.89.23/voz.io-11369" id="995bc4e3-9c55-40d8-874b-46af79c0b22a" type="result">
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment