Skip to content

Instantly share code, notes, and snippets.

@neerajnagi
Created March 3, 2014 22:20
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/9335868 to your computer and use it in GitHub Desktop.
Save neerajnagi/9335868 to your computer and use it in GitHub Desktop.
2014-03-03 23:23:27.931130 [NOTICE] switch_channel.c:1053 New Channel sofia/internal/test7@176.9.89.23 [54173acc-0fd9-dc5e-4924-6e28477897c6]
2014-03-03 23:23:27.931130 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/test7@176.9.89.23 [BREAK]
2014-03-03 23:23:27.931130 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/test7@176.9.89.23 [BREAK]
2014-03-03 23:23:27.931130 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/test7@176.9.89.23) Running State Change CS_NEW
2014-03-03 23:23:27.931130 [DEBUG] sofia.c:8211 sofia/internal/test7@176.9.89.23 receiving invite from 202.157.93.2:59343 version: 1.5.11b git 4b6c08b 2014-02-28 02:17:26Z 64bit
2014-03-03 23:23:27.931130 [DEBUG] sofia.c:8378 IP 202.157.93.2 Rejected by acl "domains". Falling back to Digest auth.
2014-03-03 23:23:27.931130 [DEBUG] switch_core_state_machine.c:486 (sofia/internal/test7@176.9.89.23) State NEW
2014-03-03 23:23:27.931130 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/test7@176.9.89.23 [BREAK]
2014-03-03 23:23:27.931130 [DEBUG] sofia.c:2034 detaching session 54173acc-0fd9-dc5e-4924-6e28477897c6
2014-03-03 23:23:28.171130 [DEBUG] sofia.c:2126 Re-attaching to session 54173acc-0fd9-dc5e-4924-6e28477897c6
2014-03-03 23:23:28.171130 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/test7@176.9.89.23 [BREAK]
2014-03-03 23:23:28.171130 [DEBUG] switch_core_session.c:1049 Send signal sofia/internal/test7@176.9.89.23 [BREAK]
2014-03-03 23:23:28.191104 [DEBUG] sofia.c:8211 sofia/internal/test7@176.9.89.23 receiving invite from 202.157.93.2:59343 version: 1.5.11b git 4b6c08b 2014-02-28 02:17:26Z 64bit
2014-03-03 23:23:28.191104 [DEBUG] sofia.c:8378 IP 202.157.93.2 Rejected by acl "domains". Falling back to Digest auth.
2014-03-03 23:23:28.191104 [DEBUG] sofia.c:9428 Setting NAT mode based on via received
2014-03-03 23:23:28.191104 [DEBUG] sofia.c:6136 Channel sofia/internal/test7@176.9.89.23 entering state [received][100]
2014-03-03 23:23:28.191104 [DEBUG] sofia.c:6146 Remote SDP:
v=0
o=- 4265617444470586000 2 IN IP4 127.0.0.1
s=Doubango Telecom - chrome
t=0 0
a=group:BUNDLE audio video
a=msid-semantic: WMS i586BEaTGgXOITCcH0lnSn4IdvnV5qiSzjHL
m=audio 64990 RTP/SAVPF 111 103 104 0 8 106 105 13 126
c=IN IP4 10.100.101.254
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:106 CN/32000
a=rtpmap:105 CN/16000
a=rtpmap:13 CN/8000
a=rtpmap:126 telephone-event/8000
a=rtcp:64990 IN IP4 10.100.101.254
a=candidate:524234378 1 udp 2122260223 10.100.101.254 64990 typ host generation 0
a=candidate:524234378 2 udp 2122260223 10.100.101.254 64990 typ host generation 0
a=candidate:1371329146 1 tcp 1518280447 10.100.101.254 0 typ host generation 0
a=candidate:1371329146 2 tcp 1518280447 10.100.101.254 0 typ host generation 0
a=ice-ufrag:DBIppGTHYq3qWXfX
a=ice-pwd:SJTzllxFO+uC1icOimHgiCwI
a=ice-options:google-ice
a=fingerprint:sha-256 1A:E3:7B:B2:83:84:60:3F:FD:35:DD:42:A1:83:EB:55:8B:19:13:3D:6C:C9:53:70:02:FE:FE:C3:D1:66:A4:3F
a=setup:actpass
a=mid:audio
a=extmap:1 urn:ietf:params:rtp-hdrext:ssrc-audio-level
a=rtcp-mux
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:DEKQQF0540L2CXyug6eP/cRfCoVRrPjxS7toJ3bw
a=maxptime:60
a=ssrc:3302082503 cname:DmW3NeD1BscgLXqV
a=ssrc:3302082503 msid:i586BEaTGgXOITCcH0lnSn4IdvnV5qiSzjHL 177a3abc-338c-470d-858c-9662ed9275e1
a=ssrc:3302082503 mslabel:i586BEaTGgXOITCcH0lnSn4IdvnV5qiSzjHL
a=ssrc:3302082503 label:177a3abc-338c-470d-858c-9662ed9275e1
m=video 64990 RTP/SAVPF 100 116 117
c=IN IP4 10.100.101.254
a=rtpmap:100 VP8/90000
a=rtpmap:116 red/90000
a=rtpmap:117 ulpfec/90000
a=rtcp:64990 IN IP4 10.100.101.254
a=candidate:524234378 1 udp 2122260223 10.100.101.254 64990 typ host generation 0
a=candidate:524234378 2 udp 2122260223 10.100.101.254 64990 typ host generation 0
a=candidate:1371329146 1 tcp 1518280447 10.100.101.254 0 typ host generation 0
a=candidate:1371329146 2 tcp 1518280447 10.100.101.254 0 typ host generation 0
a=ice-ufrag:DBIppGTHYq3qWXfX
a=ice-pwd:SJTzllxFO+uC1icOimHgiCwI
a=ice-options:google-ice
a=fingerprint:sha-256 1A:E3:7B:B2:83:84:60:3F:FD:35:DD:42:A1:83:EB:55:8B:19:13:3D:6C:C9:53:70:02:FE:FE:C3:D1:66:A4:3F
a=setup:actpass
a=mid:video
a=extmap:2 urn:ietf:params:rtp-hdrext:toffset
a=extmap:3 http://www.webrtc.org/experiments/rtp-hdrext/abs-send-time
a=rtcp-mux
a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:DEKQQF0540L2CXyug6eP/cRfCoVRrPjxS7toJ3bw
a=rtcp-fb:100 ccm fir
a=rtcp-fb:100 nack
a=rtcp-fb:100 nack pli
a=rtcp-fb:100 goog-remb
a=ssrc:133283498 cname:DmW3NeD1BscgLXqV
a=ssrc:133283498 msid:i586BEaTGgXOITCcH0lnSn4IdvnV5qiSzjHL 37d7a9e7-82f0-41e5-9ac8-17b703fa6991
a=ssrc:133283498 mslabel:i586BEaTGgXOITCcH0lnSn4IdvnV5qiSzjHL
a=ssrc:133283498 label:37d7a9e7-82f0-41e5-9ac8-17b703fa6991
2014-03-03 23:23:28.191104 [DEBUG] sofia.c:6401 (sofia/internal/test7@176.9.89.23) State Change CS_NEW -> CS_INIT
2014-03-03 23:23:28.191104 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/test7@176.9.89.23 [BREAK]
2014-03-03 23:23:28.191104 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/test7@176.9.89.23) Running State Change CS_INIT
2014-03-03 23:23:28.191104 [DEBUG] switch_core_state_machine.c:507 (sofia/internal/test7@176.9.89.23) State INIT
2014-03-03 23:23:28.191104 [DEBUG] mod_sofia.c:87 sofia/internal/test7@176.9.89.23 SOFIA INIT
2014-03-03 23:23:28.191104 [DEBUG] switch_core_state_machine.c:40 sofia/internal/test7@176.9.89.23 Standard INIT
2014-03-03 23:23:28.191104 [DEBUG] switch_core_state_machine.c:48 (sofia/internal/test7@176.9.89.23) State Change CS_INIT -> CS_ROUTING
2014-03-03 23:23:28.191104 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/test7@176.9.89.23 [BREAK]
2014-03-03 23:23:28.191104 [DEBUG] switch_core_state_machine.c:507 (sofia/internal/test7@176.9.89.23) State INIT going to sleep
2014-03-03 23:23:28.191104 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/test7@176.9.89.23) Running State Change CS_ROUTING
2014-03-03 23:23:28.191104 [DEBUG] switch_channel.c:2177 (sofia/internal/test7@176.9.89.23) Callstate Change DOWN -> RINGING
2014-03-03 23:23:28.191104 [DEBUG] switch_core_state_machine.c:523 (sofia/internal/test7@176.9.89.23) State ROUTING
2014-03-03 23:23:28.191104 [DEBUG] mod_sofia.c:123 sofia/internal/test7@176.9.89.23 SOFIA ROUTING
2014-03-03 23:23:28.191104 [DEBUG] switch_core_state_machine.c:164 sofia/internal/test7@176.9.89.23 Standard ROUTING
2014-03-03 23:23:28.191104 [INFO] mod_dialplan_xml.c:558 Processing test7 <test7>->+525556607221 in context default
Dialplan: sofia/internal/test7@176.9.89.23 parsing [default->call_transfer] continue=false
Dialplan: sofia/internal/test7@176.9.89.23 Regex (FAIL) [call_transfer] rdnis() =~ /^.+$/ break=on-false
Dialplan: sofia/internal/test7@176.9.89.23 parsing [default->Adhearsion] continue=false
Dialplan: sofia/internal/test7@176.9.89.23 Regex (PASS) [Adhearsion] destination_number(+525556607221) =~ /.*$/ break=on-false
Dialplan: sofia/internal/test7@176.9.89.23 Action set(sip_h_X-route=DEFAULT)
Dialplan: sofia/internal/test7@176.9.89.23 Action set(domain_name=176.9.89.23)
Dialplan: sofia/internal/test7@176.9.89.23 Action set(hangup_after_bridge=false)
Dialplan: sofia/internal/test7@176.9.89.23 Action rayo()
2014-03-03 23:23:28.191104 [DEBUG] switch_core_state_machine.c:214 (sofia/internal/test7@176.9.89.23) State Change CS_ROUTING -> CS_EXECUTE
2014-03-03 23:23:28.191104 [DEBUG] switch_core_session.c:1384 Send signal sofia/internal/test7@176.9.89.23 [BREAK]
2014-03-03 23:23:28.191104 [DEBUG] switch_core_state_machine.c:523 (sofia/internal/test7@176.9.89.23) State ROUTING going to sleep
2014-03-03 23:23:28.191104 [DEBUG] switch_core_state_machine.c:467 (sofia/internal/test7@176.9.89.23) Running State Change CS_EXECUTE
2014-03-03 23:23:28.191104 [DEBUG] switch_core_state_machine.c:530 (sofia/internal/test7@176.9.89.23) State EXECUTE
2014-03-03 23:23:28.191104 [DEBUG] mod_sofia.c:178 sofia/internal/test7@176.9.89.23 SOFIA EXECUTE
2014-03-03 23:23:28.191104 [DEBUG] switch_core_state_machine.c:256 sofia/internal/test7@176.9.89.23 Standard EXECUTE
EXECUTE sofia/internal/test7@176.9.89.23 set(sip_h_X-route=DEFAULT)
2014-03-03 23:23:28.191104 [DEBUG] mod_dptools.c:1409 sofia/internal/test7@176.9.89.23 SET [sip_h_X-route]=[DEFAULT]
2014-03-03 23:23:28.191104 [DEBUG] mod_rayo.c:3228 got event CHANNEL_EXECUTE
2014-03-03 23:23:28.191104 [DEBUG] mod_rayo.c:3228 got event CHANNEL_EXECUTE_COMPLETE
EXECUTE sofia/internal/test7@176.9.89.23 set(domain_name=176.9.89.23)
2014-03-03 23:23:28.191104 [DEBUG] mod_rayo.c:3228 got event CHANNEL_EXECUTE
2014-03-03 23:23:28.191104 [DEBUG] mod_dptools.c:1409 sofia/internal/test7@176.9.89.23 SET [domain_name]=[176.9.89.23]
2014-03-03 23:23:28.191104 [DEBUG] mod_rayo.c:3228 got event CHANNEL_EXECUTE_COMPLETE
EXECUTE sofia/internal/test7@176.9.89.23 set(hangup_after_bridge=false)
2014-03-03 23:23:28.191104 [DEBUG] mod_rayo.c:3228 got event CHANNEL_EXECUTE
2014-03-03 23:23:28.191104 [DEBUG] mod_dptools.c:1409 sofia/internal/test7@176.9.89.23 SET [hangup_after_bridge]=[false]
2014-03-03 23:23:28.191104 [DEBUG] mod_rayo.c:3228 got event CHANNEL_EXECUTE_COMPLETE
EXECUTE sofia/internal/test7@176.9.89.23 rayo()
2014-03-03 23:23:28.191104 [DEBUG] mod_rayo.c:3228 got event CHANNEL_EXECUTE
2014-03-03 23:23:28.191104 [DEBUG] mod_rayo.c:3403 Init 54173acc-0fd9-dc5e-4924-6e28477897c6@176.9.89.23
2014-03-03 23:23:28.191104 [DEBUG] mod_rayo.c:3408 Offering call for Rayo 3PCC
2014-03-03 23:23:28.191104 [DEBUG] mod_rayo.c:704 Locate (jid) 1@176.9.89.23/voz.io-11369: ref count = 2
2014-03-03 23:23:28.191104 [DEBUG] mod_rayo.c:3426 Deliver 54173acc-0fd9-dc5e-4924-6e28477897c6@176.9.89.23 => 1@176.9.89.23/voz.io-11369 <presence from='54173acc-0fd9-dc5e-4924-6e28477897c6@176.9.89.23' 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=E8u5o8S7kHdAz0I4BSAN'/><header name='to' value='&lt;sip:+525556607221@176.9.89.23&gt;'/><header name='via' value='SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKN8y39hmw3zT4dP30z4H2X9gsg796iWAI;rport=59343;received=202.157.93.2'/><header name='X-route' value='DEFAULT'/></offer></presence>
2014-03-03 23:23:28.191104 [DEBUG] mod_rayo.c:711 Unlock 1@176.9.89.23/voz.io-11369: ref count = 1
2014-03-03 23:23:28.191104 [DEBUG] mod_rayo.c:3228 got event CHANNEL_PARK
2014-03-03 23:23:28.211130 [DEBUG] xmpp_streams.c:190 c2s_in 1@176.9.89.23/voz.io-11369 SEND <presence from='54173acc-0fd9-dc5e-4924-6e28477897c6@176.9.89.23' 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=E8u5o8S7kHdAz0I4BSAN'/><header name='to' value='&lt;sip:+525556607221@176.9.89.23&gt;'/><header name='via' value='SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKN8y39hmw3zT4dP30z4H2X9gsg796iWAI;rport=59343;received=202.157.93.2'/><header name='X-route' value='DEFAULT'/></offer></presence>
freeswitch@internal>
freeswitch@internal>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN>
AHN> [2014-03-03 23:23:14.472] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="c22de918-5019-08c0-20e6-38481fbbfa4e@176.9.89.23" 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:hector.gil_web93.mx@176.9.89.23" to="sip:+525558555100@176.9.89.23">
<header name="from" value="&quot;Hector&quot; &lt;sip:hector.gil_web93.mx@176.9.89.23&gt;;tag=IPFDBHMxgmXEqAiGNC4a"/>
<header name="to" value="&lt;sip:+525558555100@176.9.89.23&gt;"/>
<header name="via" value="SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKXm3ZHfg4xFr1TgPbGegaWEDdeqwXW53r;rport=50067;received=187.147.142.169"/>
<header name="X-route" value="DEFAULT"/>
</offer>
</presence>
[2014-03-03 23:23:14.955] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="2bd456e4-c663-cd9b-0092-a86e1a7f3498@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:23:28.216] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="54173acc-0fd9-dc5e-4924-6e28477897c6@176.9.89.23" 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=E8u5o8S7kHdAz0I4BSAN"/>
<header name="to" value="&lt;sip:+525556607221@176.9.89.23&gt;"/>
<header name="via" value="SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKN8y39hmw3zT4dP30z4H2X9gsg796iWAI;rport=59343;received=202.157.93.2"/>
<header name="X-route" value="DEFAULT"/>
</offer>
</presence>
[2014-03-03 23:23:31.334] 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="get" to="176.9.89.23" id="blather025b">
<ping xmlns="urn:xmpp:ping"/>
</iq>
[2014-03-03 23:23:31.355] TRACE Punchblock::Connection::XMPP: RECEIVING (iq) <iq type="result" from="176.9.89.23" to="1@176.9.89.23/voz.io-11369" id="blather025b"/>
[2014-03-03 23:23:31.356] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="65c397d7-e64a-fb3d-4601-a8f981be7339@176.9.89.23" 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:+529999436134@176.9.89.23">
<header name="from" value="&quot;Pedro&quot; &lt;sip:pedro.sarabia_web93.mx@176.9.89.23&gt;;tag=OWPkQd6KBq5VSQNqUXyH"/>
<header name="to" value="&lt;sip:+529999436134@176.9.89.23&gt;"/>
<header name="via" value="SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKuucv2QbvBxWgFpMpBxA5LTXfvAHhW0zy;rport=41525;received=187.147.142.169"/>
<header name="X-route" value="DEFAULT"/>
</offer>
</presence>
[2014-03-03 23:23:32.524] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="4b380261-930a-df42-1b3f-e13dd14c64af@176.9.89.23" 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:lester.cuevas_web93.mx@176.9.89.23" to="sip:+525554208685@176.9.89.23">
<header name="from" value="&quot;Lester&quot; &lt;sip:lester.cuevas_web93.mx@176.9.89.23&gt;;tag=6CJ4aKUNVi5VB7Brtge3"/>
<header name="to" value="&lt;sip:+525554208685@176.9.89.23&gt;"/>
<header name="via" value="SIP/2.0/WS df7jal23ls0d.invalid;branch=z9hG4bKKmKgCQPihlrNC6ow0T6Mw7Hz6NpTkevS;rport=48525;received=187.147.142.169"/>
<header name="X-route" value="DEFAULT"/>
</offer>
</presence>
[2014-03-03 23:23:39.130] TRACE Punchblock::Connection::XMPP: RECEIVING (presence) <presence from="c22de918-5019-08c0-20e6-38481fbbfa4e@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>
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment