Advertisement
Not a member of Pastebin yet?
Sign Up,
it unlocks many cool features!
- span class="re2"> 2015-02-18 10:50:38.980765 [DEBUG] switch_core_session.c:1052 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:38.980765 [DEBUG] sofia.c:2033 detaching session ppF_pmaC4dt1uXp-2_KLbA..
- recv 369 bytes from udp/[192.99.2.170]:5060 at 10:50:38.989834:
- ------------------------------------------------------------------------
- ACK sip:104@revolt.revoltcloud.com;transport=TLS SIP/2.0
- Via: SIP/2.0/UDP 192.99.2.170;branch=z9hG4bK2bd6.69dc0c01.0;i=2955
- Max-Forwards: 50
- To: <sip:104@revolt.revoltcloud.com;transport=TLS>;tag=Ucryv1FZFF4em
- From: "17187637958"<sip:davidcell@revolt.revoltcloud.com;transport=TLS>;tag=5794f71e
- Call-ID: ppF_pmaC4dt1uXp-2_KLbA..
- CSeq: 1 ACK
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 1603 bytes from udp/[192.99.2.170]:5060 at 10:50:39.119906:
- ------------------------------------------------------------------------
- INVITE sip:104@revolt.revoltcloud.com;transport=TLS SIP/2.0
- Record-Route: <sip:192.99.2.170;r2=on;lr=on;ftag=5794f71e>
- Record-Route: <sip:192.99.2.170:5061;transport=tls;r2=on;lr=on;ftag=5794f71e>
- Via: SIP/2.0/UDP 192.99.2.170;branch=z9hG4bKfad6.848ab8d3.0;i=2955
- Via: SIP/2.0/TLS 100.38.128.26:38715;branch=z9hG4bK-524287-1---2ebb89807096d777;rport=38715
- Max-Forwards: 50
- Contact: <sip:davidcell@100.38.128.26:38715;transport=TLS>
- To: <sip:104@revolt.revoltcloud.com;transport=TLS>
- From: "17187637958"<sip:davidcell@revolt.revoltcloud.com;transport=TLS>;tag=5794f71e
- Call-ID: ppF_pmaC4dt1uXp-2_KLbA..
- CSeq: 2 INVITE
- Allow: INVITE, ACK, CANCEL, BYE, NOTIFY, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
- Content-Type: application/sdp
- Proxy-Authorization: Digest username="davidcell",realm="revolt.revoltcloud.com",nonce="e2b32634-b785-11e4-81f0-135f369896d1",uri="sip:104@revolt.revoltcloud.com;transport=TLS",response="00acdbc654778848e8cf462176b3276a",cnonce="e676edaa0ab2b76d34c6937a1d7aab9a",nc=00000001,qop=auth,algorithm=MD5
- Supported: replaces, norefersub, extended-refer, timer, outbound, path, X-cisco-serviceuri
- User-Agent: Zoiper r29567
- Allow-Events: presence, kpml
- Content-Length: 365
- X-AUTH-IP: 100.38.128.26
- v=0
- o=Zoiper 0 0 IN IP4 100.38.128.26
- s=Zoiper
- c=IN IP4 100.38.128.26
- t=0 0
- m=audio 52734 RTP/SAVP 0 101
- a=rtpmap:0 PCMU/8000
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=sendrecv
- a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:g6pJL/yWKnwewA+jQEG900eSXoOLy3FOJvyvioyn
- a=crypto:2 AES_CM_128_HMAC_SHA1_32 inline:g6pJL/yWKnwewA+jQEG900eSXoOLy3FOJvyvioyn
- ------------------------------------------------------------------------
- send 550 bytes to udp/[192.99.2.170]:5060 at 10:50:39.120211:
- ------------------------------------------------------------------------
- SIP/2.0 100 Trying
- Via: SIP/2.0/UDP 192.99.2.170;branch=z9hG4bKfad6.848ab8d3.0;i=2955
- Via: SIP/2.0/TLS 100.38.128.26:38715;branch=z9hG4bK-524287-1---2ebb89807096d777;rport=38715
- Record-Route: <sip:192.99.2.170;r2=on;lr=on;ftag=5794f71e>
- Record-Route: <sip:192.99.2.170:5061;transport=tls;r2=on;lr=on;ftag=5794f71e>
- From: "17187637958"<sip:davidcell@revolt.revoltcloud.com;transport=TLS>;tag=5794f71e
- To: <sip:104@revolt.revoltcloud.com;transport=TLS>
- Call-ID: ppF_pmaC4dt1uXp-2_KLbA..
- CSeq: 2 INVITE
- User-Agent: 2600hz
- Content-Length: 0
- ------------------------------------------------------------------------
- 2015-02-18 10:50:39.100767 [DEBUG] sofia.c:2138 Re-attaching to session ppF_pmaC4dt1uXp-2_KLbA..
- 2015-02-18 10:50:39.100767 [DEBUG] switch_core_session.c:1052 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:39.100767 [DEBUG] switch_core_session.c:1052 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:39.120766 [DEBUG] sofia.c:8703 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com receiving invite from 192.99.2.170:5060 version: 1.4.7 64bit
- 2015-02-18 10:50:39.120766 [DEBUG] sofia.c:8825 1 acls to check for proxy
- 2015-02-18 10:50:39.120766 [DEBUG] sofia.c:8830 checking 192.99.2.170 against acl authoritative
- 2015-02-18 10:50:39.120766 [INFO] sofia.c:8832 192.99.2.170 is a proxy according to the authoritative acl
- 2015-02-18 10:50:39.120766 [DEBUG] sofia.c:8842 network ip is a proxy
- 2015-02-18 10:50:39.120766 [DEBUG] sofia.c:8846 found auth ip [X-AUTH-IP] header of [100.38.128.26]
- 2015-02-18 10:50:39.120766 [DEBUG] sofia.c:8870 IP 192.99.2.170 Rejected by acl "trusted". Falling back to Digest auth.
- 2015-02-18 10:50:39.120766 [DEBUG] kazoo_fetch_agent.c:216 Sending directory XML request (e2c8b03a-b785-11e4-81f1-135f369896d1) to ecallmgr@ns5000330.ip-192-99-2.net <3.1239.264>
- 2015-02-18 10:50:39.280761 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.1239.264>
- 2015-02-18 10:50:39.280761 [DEBUG] kazoo_fetch_agent.c:277 Received directory XML (e2c8b03a-b785-11e4-81f1-135f369896d1) after 159ms: <document type="freeswitch/xml"><section name="directory"><domain name="revolt.revoltcloud.com"><user id="davidcell" cacheable="3600000"><variables><variable name="ecallmgr_Presence-ID" value="DJ_411@revolt.revoltcloud.com"/><variable name="ecallmgr_Account-Name" value="revolt"/><variable name="ecallmgr_Account-Realm" value="revolt.revoltcloud.com"/><variable name="ecallmgr_Owner-ID" value="ab3ea2d6cde9a50b7277be9a4b349ef5"/><variable name="ecallmgr_Authorizing-Type" value="device"/><variable name="ecallmgr_Authorizing-ID" value="bad682a151246e85540184d61b5678ae"/><variable name="ecallmgr_Account-ID" value="e5ef4eef7ac70533b19c803b35d6a10d"/><variable name="ecallmgr_Realm" value="revolt.revoltcloud.com"/><variable name="ecallmgr_Username" value="davidcell"/></variables><params><param name="password" value="Dj123456"/></params></user></domain></section></document>
- 2015-02-18 10:50:39.280761 [DEBUG] switch_xml.c:2098 caching lookup for user davidcell@revolt.revoltcloud.com for 3600 seconds
- 2015-02-18 10:50:39.280761 [DEBUG] sofia.c:6413 Channel sofia/sipinterface_1/davidcell@revolt.revoltcloud.com entering state [received][100]
- 2015-02-18 10:50:39.280761 [DEBUG] sofia.c:6423 Remote SDP:
- v=0
- o=Zoiper 0 0 IN IP4 100.38.128.26
- s=Zoiper
- c=IN IP4 100.38.128.26
- t=0 0
- m=audio 52734 RTP/SAVP 0 101
- a=rtpmap:0 PCMU/8000
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:g6pJL/yWKnwewA+jQEG900eSXoOLy3FOJvyvioyn
- a=crypto:2 AES_CM_128_HMAC_SHA1_32 inline:g6pJL/yWKnwewA+jQEG900eSXoOLy3FOJvyvioyn
- 2015-02-18 10:50:39.280761 [DEBUG] sofia.c:6678 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State Change CS_NEW -> CS_INIT
- 2015-02-18 10:50:39.280761 [DEBUG] switch_core_session.c:1387 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:39.280761 [DEBUG] switch_core_state_machine.c:470 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) Running State Change CS_INIT
- 2015-02-18 10:50:39.280761 [DEBUG] switch_core_state_machine.c:510 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State INIT
- 2015-02-18 10:50:39.280761 [DEBUG] mod_sofia.c:87 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com SOFIA INIT
- 2015-02-18 10:50:39.280761 [DEBUG] switch_core_state_machine.c:40 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Standard INIT
- 2015-02-18 10:50:39.280761 [DEBUG] switch_core_state_machine.c:48 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State Change CS_INIT -> CS_ROUTING
- 2015-02-18 10:50:39.280761 [DEBUG] switch_core_session.c:1387 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:39.280761 [DEBUG] switch_core_state_machine.c:510 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State INIT going to sleep
- 2015-02-18 10:50:39.280761 [DEBUG] switch_core_state_machine.c:470 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) Running State Change CS_ROUTING
- 2015-02-18 10:50:39.280761 [DEBUG] switch_channel.c:2179 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) Callstate Change DOWN -> RINGING
- 2015-02-18 10:50:39.280761 [DEBUG] switch_core_state_machine.c:526 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State ROUTING
- 2015-02-18 10:50:39.280761 [DEBUG] mod_sofia.c:123 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com SOFIA ROUTING
- 2015-02-18 10:50:39.280761 [DEBUG] switch_core_state_machine.c:164 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Standard ROUTING
- 2015-02-18 10:50:39.280761 [INFO] mod_dialplan_xml.c:558 Processing 17187637958 <davidcell>->104 in context context_2
- 2015-02-18 10:50:39.280761 [DEBUG] kazoo_fetch_agent.c:216 Sending dialplan XML request (e2e0524e-b785-11e4-81f3-135f369896d1) to ecallmgr@ns5000330.ip-192-99-2.net <3.1248.264>
- 2015-02-18 10:50:39.480766 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.1248.264>
- 2015-02-18 10:50:39.500766 [DEBUG] kazoo_fetch_agent.c:277 Received dialplan XML (e2e0524e-b785-11e4-81f3-135f369896d1) after 220ms: <document type="freeswitch/xml"><section name="dialplan" description="Route Park Response"><context name="context_2"><extension name="park"><condition><action application="log" data="NOTICE log|${uuid}|ecallmgr@ns5000330.ip-192-99-2.net won call control"/><action application="export" data="ecallmgr_Ecallmgr-Node=ecallmgr@ns5000330.ip-192-99-2.net"/><condition field="variable_ecallmgr_Bridge-ID" expression="^$"><action application="export" data="ecallmgr_Bridge-ID=${UUID}"/></condition><action application="set" data="ringback=%(2000,4000,440,480)"/><action application="set" data="transfer_ringback=%(2000,4000,440,480)"/><action application="park"/></condition></extension></context></section></document>
- Dialplan: sofia/sipinterface_1/davidcell@revolt.revoltcloud.com parsing [context_2->park] continue=false
- |--- Dialplan: Processing recursive conditions level:1 [park_recur_1] require-nested=TRUE
- |--- Dialplan: sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Regex (PASS) [park_recur_1] variable_ecallmgr_Bridge-ID() =~ /^$/ break=on-false
- |--- Dialplan: sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Action export(ecallmgr_Bridge-ID=${UUID})
- Dialplan: sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Absolute Condition [park]
- Dialplan: sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Action log(NOTICE log|${uuid}|ecallmgr@ns5000330.ip-192-99-2.net won call control)
- Dialplan: sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Action export(ecallmgr_Ecallmgr-Node=ecallmgr@ns5000330.ip-192-99-2.net)
- Dialplan: sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Action set(ringback=%(2000,4000,440,480))
- Dialplan: sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Action set(transfer_ringback=%(2000,4000,440,480))
- Dialplan: sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Action park()
- 2015-02-18 10:50:39.500766 [DEBUG] switch_core_state_machine.c:214 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State Change CS_ROUTING -> CS_EXECUTE
- 2015-02-18 10:50:39.500766 [DEBUG] switch_core_session.c:1387 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:39.500766 [DEBUG] switch_core_state_machine.c:526 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State ROUTING going to sleep
- 2015-02-18 10:50:39.500766 [DEBUG] switch_core_state_machine.c:470 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) Running State Change CS_EXECUTE
- 2015-02-18 10:50:39.500766 [DEBUG] switch_core_state_machine.c:533 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State EXECUTE
- 2015-02-18 10:50:39.500766 [DEBUG] mod_sofia.c:178 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com SOFIA EXECUTE
- 2015-02-18 10:50:39.500766 [DEBUG] switch_core_state_machine.c:256 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Standard EXECUTE
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com export(ecallmgr_Bridge-ID=ppF_pmaC4dt1uXp-2_KLbA..)
- 2015-02-18 10:50:39.500766 [CONSOLE] sofia_presence.c:1617 Event Thread Started
- 2015-02-18 10:50:39.500766 [DEBUG] switch_channel.c:1246 EXPORT (export_vars) [ecallmgr_Bridge-ID]=[ppF_pmaC4dt1uXp-2_KLbA..]
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com log(NOTICE log|ppF_pmaC4dt1uXp-2_KLbA..|ecallmgr@ns5000330.ip-192-99-2.net won call control)
- 2015-02-18 10:50:39.500766 [NOTICE] mod_dptools.c:1667 log|ppF_pmaC4dt1uXp-2_KLbA..|ecallmgr@ns5000330.ip-192-99-2.net won call control
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com export(ecallmgr_Ecallmgr-Node=ecallmgr@ns5000330.ip-192-99-2.net)
- 2015-02-18 10:50:39.500766 [DEBUG] switch_channel.c:1246 EXPORT (export_vars) [ecallmgr_Ecallmgr-Node]=[ecallmgr@ns5000330.ip-192-99-2.net]
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com set(ringback=%(2000,4000,440,480))
- 2015-02-18 10:50:39.500766 [DEBUG] mod_dptools.c:1435 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com SET [ringback]=[%(2000,4000,440,480)]
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com set(transfer_ringback=%(2000,4000,440,480))
- 2015-02-18 10:50:39.500766 [DEBUG] mod_dptools.c:1435 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com SET [transfer_ringback]=[%(2000,4000,440,480)]
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com park()
- 2015-02-18 10:50:39.700765 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.2071.264>
- 2015-02-18 10:50:39.700765 [INFO] kazoo_node.c:625 exec: uuid_setvar_multi(ppF_pmaC4dt1uXp-2_KLbA.. effective_caller_id_name=David Johnson;effective_caller_id_number=+17187637958;rtp_secure_media=true;ecallmgr_Fetch-ID=e2e0524e-b785-11e4-81f3-135f369896d1;ecallmgr_Username=davidcell;ecallmgr_Realm=revolt.revoltcloud.com;ecallmgr_Account-ID=e5ef4eef7ac70533b19c803b35d6a10d;ecallmgr_Authorizing-ID=bad682a151246e85540184d61b5678ae;ecallmgr_Authorizing-Type=device;ecallmgr_Owner-ID=ab3ea2d6cde9a50b7277be9a4b349ef5;ecallmgr_Account-Realm=revolt.revoltcloud.com;ecallmgr_Account-Name=revolt;presence_id=DJ_411@revolt.revoltcloud.com)
- 2015-02-18 10:50:39.900766 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.2086.264>
- 2015-02-18 10:50:39.900766 [NOTICE] kazoo_node.c:302 log|ppF_pmaC4dt1uXp-2_KLbA..|building xferext extension: set continue_on_fail=true
- 2015-02-18 10:50:39.900766 [NOTICE] kazoo_node.c:302 log|ppF_pmaC4dt1uXp-2_KLbA..|building xferext extension: export sip_redirect_context=context_2
- 2015-02-18 10:50:39.900766 [NOTICE] kazoo_node.c:302 log|ppF_pmaC4dt1uXp-2_KLbA..|building xferext extension: set hangup_after_bridge=true
- 2015-02-18 10:50:39.900766 [NOTICE] kazoo_node.c:302 log|ppF_pmaC4dt1uXp-2_KLbA..|building xferext extension: export ecallmgr_Inception=${ecallmgr_Inception}
- 2015-02-18 10:50:39.900766 [NOTICE] kazoo_node.c:302 log|ppF_pmaC4dt1uXp-2_KLbA..|building xferext extension: bridge {ignore_early_media='true',call_timeout=30,originate_timeout=30,local_var_clobber='true'}[ecallmgr_Authorizing-ID='2fe1696b2c1df8ac2a4061f1af6850d2',ecallmgr_Owner-ID='8032190f6bf815ec0bfae6ab3f18fdcd',ecallmgr_Account-ID='e5ef4eef7ac70533b19c803b35d6a10d',sdp_secure_savp_only='true',rtp_secure_media='true',sip_invite_domain='revolt.revoltcloud.com',presence_id='developer@revolt.revoltcloud.com',absolute_codec_string='^^:PCMU:VP8:H264:H263:H261',leg_delay_start='10',leg_timeout='20',effective_callee_id_number='+17184730090',effective_callee_id_name='ReVolt Cloud',origination_callee_id_number='+17184730090',origination_callee_id_name='ReVolt Cloud',ecallmgr_Realm='revolt.revoltcloud.com',ecallmgr_Username='developer']sofia/sipinterface_1/104@116.73.69.177:61575;transport=TLS;fs_path=sip:192.99.2.170:5061;lr;received='sip:116.73.69.177:61575;transport=TLS'
- 2015-02-18 10:50:39.900766 [NOTICE] kazoo_node.c:302 log|ppF_pmaC4dt1uXp-2_KLbA..|building xferext extension: event Event-Name=CUSTOM,Event-Subclass=whistle::masquerade,whistle_event_name=CHANNEL_EXECUTE_COMPLETE,whistle_application_name=bridge
- 2015-02-18 10:50:39.900766 [NOTICE] kazoo_node.c:302 log|ppF_pmaC4dt1uXp-2_KLbA..|building xferext extension: park
- 2015-02-18 10:50:39.900766 [NOTICE] kazoo_node.c:305 log|ppF_pmaC4dt1uXp-2_KLbA..|transfered call to xferext extension
- 2015-02-18 10:50:39.900766 [DEBUG] switch_core_session.c:1187 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_channel.c:3098 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State Change CS_EXECUTE -> CS_ROUTING
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_session.c:1387 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:533 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State EXECUTE going to sleep
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:470 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) Running State Change CS_ROUTING
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:526 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State ROUTING
- 2015-02-18 10:50:39.920767 [DEBUG] mod_sofia.c:123 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com SOFIA ROUTING
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:164 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Standard ROUTING
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:184 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State Change CS_ROUTING -> CS_EXECUTE
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_session.c:1387 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:526 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State ROUTING going to sleep
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:470 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) Running State Change CS_EXECUTE
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:533 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State EXECUTE
- 2015-02-18 10:50:39.920767 [DEBUG] mod_sofia.c:178 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com SOFIA EXECUTE
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:256 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Standard EXECUTE
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com set(continue_on_fail=true)
- 2015-02-18 10:50:39.920767 [DEBUG] mod_dptools.c:1435 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com SET [continue_on_fail]=[true]
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com export(sip_redirect_context=context_2)
- 2015-02-18 10:50:39.920767 [DEBUG] switch_channel.c:1246 EXPORT (export_vars) [sip_redirect_context]=[context_2]
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com set(hangup_after_bridge=true)
- 2015-02-18 10:50:39.920767 [DEBUG] mod_dptools.c:1435 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com SET [hangup_after_bridge]=[true]
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com export(ecallmgr_Inception=)
- 2015-02-18 10:50:39.920767 [DEBUG] switch_channel.c:1246 EXPORT (export_vars) [ecallmgr_Inception]=[UNDEF]
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com bridge({ignore_early_media='true',call_timeout=30,originate_timeout=30,local_var_clobber='true'}[ecallmgr_Authorizing-ID='2fe1696b2c1df8ac2a4061f1af6850d2',ecallmgr_Owner-ID='8032190f6bf815ec0bfae6ab3f18fdcd',ecallmgr_Account-ID='e5ef4eef7ac70533b19c803b35d6a10d',sdp_secure_savp_only='true',rtp_secure_media='true',sip_invite_domain='revolt.revoltcloud.com',presence_id='developer@revolt.revoltcloud.com',absolute_codec_string='^^:PCMU:VP8:H264:H263:H261',leg_delay_start='10',leg_timeout='20',effective_callee_id_number='+17184730090',effective_callee_id_name='ReVolt Cloud',origination_callee_id_number='+17184730090',origination_callee_id_name='ReVolt Cloud',ecallmgr_Realm='revolt.revoltcloud.com',ecallmgr_Username='developer']sofia/sipinterface_1/104@116.73.69.177:61575;transport=TLS;fs_path=sip:192.99.2.170:5061;lr;received='sip:116.73.69.177:61575;transport=TLS')
- 2015-02-18 10:50:39.920767 [DEBUG] switch_channel.c:1200 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com EXPORTING[export_vars] [ecallmgr_Bridge-ID]=[ppF_pmaC4dt1uXp-2_KLbA..] to event
- 2015-02-18 10:50:39.920767 [DEBUG] switch_channel.c:1200 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com EXPORTING[export_vars] [ecallmgr_Ecallmgr-Node]=[ecallmgr@ns5000330.ip-192-99-2.net] to event
- 2015-02-18 10:50:39.920767 [DEBUG] switch_channel.c:1200 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com EXPORTING[export_vars] [sip_redirect_context]=[context_2] to event
- 2015-02-18 10:50:39.920767 [DEBUG] switch_ivr_originate.c:2079 Parsing global variables
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [ignore_early_media]=[true]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [call_timeout]=[30]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [originate_timeout]=[30]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [local_var_clobber]=[true]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_ivr_originate.c:2526 Parsing session specific variables
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [ecallmgr_Authorizing-ID]=[2fe1696b2c1df8ac2a4061f1af6850d2]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [ecallmgr_Owner-ID]=[8032190f6bf815ec0bfae6ab3f18fdcd]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [ecallmgr_Account-ID]=[e5ef4eef7ac70533b19c803b35d6a10d]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [sdp_secure_savp_only]=[true]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [rtp_secure_media]=[true]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [sip_invite_domain]=[revolt.revoltcloud.com]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [presence_id]=[developer@revolt.revoltcloud.com]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [absolute_codec_string]=[^^:PCMU:VP8:H264:H263:H261]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [leg_delay_start]=[10]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [leg_timeout]=[20]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [effective_callee_id_number]=[+17184730090]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [effective_callee_id_name]=[ReVolt Cloud]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [origination_callee_id_number]=[+17184730090]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [origination_callee_id_name]=[ReVolt Cloud]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [ecallmgr_Realm]=[revolt.revoltcloud.com]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_event.c:1688 Parsing variable [ecallmgr_Username]=[developer]
- 2015-02-18 10:50:39.920767 [NOTICE] switch_channel.c:1054 New Channel sofia/sipinterface_1/104@116.73.69.177:61575 [e34323ba-b785-11e4-8202-135f369896d1]
- 2015-02-18 10:50:39.920767 [DEBUG] mod_sofia.c:4591 (sofia/sipinterface_1/104@116.73.69.177:61575) State Change CS_NEW -> CS_INIT
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_session.c:1387 Send signal sofia/sipinterface_1/104@116.73.69.177:61575 [BREAK]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_ivr_originate.c:2820 sofia/sipinterface_1/104@116.73.69.177:61575 Setting leg timeout to 20
- 2015-02-18 10:50:39.920767 [DEBUG] switch_ivr_originate.c:2838 sofia/sipinterface_1/104@116.73.69.177:61575 Setting leg delay start to 10
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:470 (sofia/sipinterface_1/104@116.73.69.177:61575) Running State Change CS_INIT
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:510 (sofia/sipinterface_1/104@116.73.69.177:61575) State INIT
- 2015-02-18 10:50:39.920767 [DEBUG] mod_sofia.c:87 sofia/sipinterface_1/104@116.73.69.177:61575 SOFIA INIT
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local audio crypto Key [1 AEAD_AES_256_GCM_8 inline:Qf5lfNuEAiUEwk6J6gsdqsltRGJKDZBgSYeZAGpzum0H9Ffogc0Ws8+nq38]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local video crypto Key [1 AEAD_AES_256_GCM_8 inline:Vy5ZzLT7Ahr6GoTohFaLi7HclCL8M7nIl+jN4LjTikL0VGW/+BVJlIgnxuc]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local audio crypto Key [2 AEAD_AES_128_GCM_8 inline:NHiLaL55HAk4OtJSWT7OlAeuADeFPeJYfMiBmw]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local video crypto Key [2 AEAD_AES_128_GCM_8 inline:BZBZK90pZgoLic4RQYsnlbCURe3QHsHGFBDJZw]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local audio crypto Key [3 AES_CM_256_HMAC_SHA1_80 inline:ptxYythiwqlgxZ5sj4oIrUtJ18280ASIyFHIqLVNfN1n14dvOj9yETYdBLUD6w]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local video crypto Key [3 AES_CM_256_HMAC_SHA1_80 inline:hTIhKGf7AyWNtxHPvEmWU/a9XmMmv5qsHdTZyekibL/gjJqf59kfTSzoEfbM7A]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local audio crypto Key [4 AES_CM_192_HMAC_SHA1_80 inline:xDYs+w8XgE6NjL1hjkO16drbhlzKcZYzY2INqfeE3jv6I31zfgE]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local video crypto Key [4 AES_CM_192_HMAC_SHA1_80 inline:ILm9DDH4nJl5WpizJIX3pWdFHSlVma7rTaU2JV/0ZW8LdlERiGk]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local audio crypto Key [5 AES_CM_128_HMAC_SHA1_80 inline:CAi+0HgwbwmUtCYueVBAoDTQVyCiEtlJQSFukua8]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local video crypto Key [5 AES_CM_128_HMAC_SHA1_80 inline:MT1QQa6e9jTBZrKJu0H4rEjIMLdAY08EIWFbmry0]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local audio crypto Key [6 AES_CM_256_HMAC_SHA1_32 inline:qbyH4F0I7tAsUe6UndfsEhBWiciCqOsoKqMvrI8KT4xu5Dgm3CYY1qY786fK9A]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local video crypto Key [6 AES_CM_256_HMAC_SHA1_32 inline:+y200iDzJn67J8Ev9E6lC/KR71IwVxmR18TDikIi3LROsvdDaBQY0DoiCGlfsg]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local audio crypto Key [7 AES_CM_192_HMAC_SHA1_32 inline:OZv2QvACSixxHeqEAytFI5Z5BfhjMSoviSHPJTuXmHcFekjK/Uc]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local video crypto Key [7 AES_CM_192_HMAC_SHA1_32 inline:vO5RJ6mECsSkCzJPlHMfvdXrA95ZYh5K+00DgUlThI8oqz/MdIg]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local audio crypto Key [8 AES_CM_128_HMAC_SHA1_32 inline:mtMTznAWm5UwV3jgUN7qM9j8uLC4P+YFGahy0ASD]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local video crypto Key [8 AES_CM_128_HMAC_SHA1_32 inline:k/tD51oKgZlJ6IjSapD+EkZstZA6izI1jFKbELl8]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local audio crypto Key [9 AES_CM_128_NULL_AUTH inline:kRbtb62SsOpd9oehkTBd5gqgq65TBWpuUWqLtsfh]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_media.c:922 Set Local video crypto Key [9 AES_CM_128_NULL_AUTH inline:UwFBxm8/HtMYmFrPYgaRvKTSzwUN6o7alFWnJmyh]
- 2015-02-18 10:50:39.920767 [DEBUG] sofia_glue.c:1197 sip:192.99.2.170:5061;transport=tls Setting proxy route to sofia/sipinterface_1/104@116.73.69.177:61575
- 2015-02-18 10:50:39.920767 [DEBUG] sofia_glue.c:1226 sofia/sipinterface_1/104@116.73.69.177:61575 sending invite version: 1.4.7 64bit
- Local SDP:
- v=0
- o=FreeSWITCH 1424252995 1424252996 IN IP4 192.99.2.226
- s=FreeSWITCH
- c=IN IP4 192.99.2.226
- t=0 0
- m=audio 21644 RTP/SAVP 0 101 13
- a=rtpmap:0 PCMU/8000
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=crypto:1 AEAD_AES_256_GCM_8 inline:Qf5lfNuEAiUEwk6J6gsdqsltRGJKDZBgSYeZAGpzum0H9Ffogc0Ws8+nq38
- a=crypto:2 AEAD_AES_128_GCM_8 inline:NHiLaL55HAk4OtJSWT7OlAeuADeFPeJYfMiBmw
- a=crypto:3 AES_CM_256_HMAC_SHA1_80 inline:ptxYythiwqlgxZ5sj4oIrUtJ18280ASIyFHIqLVNfN1n14dvOj9yETYdBLUD6w
- a=crypto:4 AES_CM_192_HMAC_SHA1_80 inline:xDYs+w8XgE6NjL1hjkO16drbhlzKcZYzY2INqfeE3jv6I31zfgE
- a=crypto:5 AES_CM_128_HMAC_SHA1_80 inline:CAi+0HgwbwmUtCYueVBAoDTQVyCiEtlJQSFukua8
- a=crypto:6 AES_CM_256_HMAC_SHA1_32 inline:qbyH4F0I7tAsUe6UndfsEhBWiciCqOsoKqMvrI8KT4xu5Dgm3CYY1qY786fK9A
- a=crypto:7 AES_CM_192_HMAC_SHA1_32 inline:OZv2QvACSixxHeqEAytFI5Z5BfhjMSoviSHPJTuXmHcFekjK/Uc
- a=crypto:8 AES_CM_128_HMAC_SHA1_32 inline:mtMTznAWm5UwV3jgUN7qM9j8uLC4P+YFGahy0ASD
- a=crypto:9 AES_CM_128_NULL_AUTH inline:kRbtb62SsOpd9oehkTBd5gqgq65TBWpuUWqLtsfh
- a=ptime:20
- a=sendrecv
- m=video 22732 RTP/SAVP 98 34 31
- a=rtpmap:98 H264/90000
- a=rtpmap:34 H263/90000
- a=rtpmap:31 H261/90000
- a=crypto:1 AEAD_AES_256_GCM_8 inline:Vy5ZzLT7Ahr6GoTohFaLi7HclCL8M7nIl+jN4LjTikL0VGW/+BVJlIgnxuc
- a=crypto:2 AEAD_AES_128_GCM_8 inline:BZBZK90pZgoLic4RQYsnlbCURe3QHsHGFBDJZw
- a=crypto:3 AES_CM_256_HMAC_SHA1_80 inline:hTIhKGf7AyWNtxHPvEmWU/a9XmMmv5qsHdTZyekibL/gjJqf59kfTSzoEfbM7A
- a=crypto:4 AES_CM_192_HMAC_SHA1_80 inline:ILm9DDH4nJl5WpizJIX3pWdFHSlVma7rTaU2JV/0ZW8LdlERiGk
- a=crypto:5 AES_CM_128_HMAC_SHA1_80 inline:MT1QQa6e9jTBZrKJu0H4rEjIMLdAY08EIWFbmry0
- a=crypto:6 AES_CM_256_HMAC_SHA1_32 inline:+y200iDzJn67J8Ev9E6lC/KR71IwVxmR18TDikIi3LROsvdDaBQY0DoiCGlfsg
- a=crypto:7 AES_CM_192_HMAC_SHA1_32 inline:vO5RJ6mECsSkCzJPlHMfvdXrA95ZYh5K+00DgUlThI8oqz/MdIg
- a=crypto:8 AES_CM_128_HMAC_SHA1_32 inline:k/tD51oKgZlJ6IjSapD+EkZstZA6izI1jFKbELl8
- a=crypto:9 AES_CM_128_NULL_AUTH inline:UwFBxm8/HtMYmFrPYgaRvKTSzwUN6o7alFWnJmyh
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:40 sofia/sipinterface_1/104@116.73.69.177:61575 Standard INIT
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:48 (sofia/sipinterface_1/104@116.73.69.177:61575) State Change CS_INIT -> CS_ROUTING
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_session.c:1387 Send signal sofia/sipinterface_1/104@116.73.69.177:61575 [BREAK]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:510 (sofia/sipinterface_1/104@116.73.69.177:61575) State INIT going to sleep
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:470 (sofia/sipinterface_1/104@116.73.69.177:61575) Running State Change CS_ROUTING
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:526 (sofia/sipinterface_1/104@116.73.69.177:61575) State ROUTING
- 2015-02-18 10:50:39.920767 [DEBUG] mod_sofia.c:123 sofia/sipinterface_1/104@116.73.69.177:61575 SOFIA ROUTING
- 2015-02-18 10:50:39.920767 [DEBUG] switch_ivr_originate.c:67 (sofia/sipinterface_1/104@116.73.69.177:61575) State Change CS_ROUTING -> CS_CONSUME_MEDIA
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_session.c:1387 Send signal sofia/sipinterface_1/104@116.73.69.177:61575 [BREAK]
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:526 (sofia/sipinterface_1/104@116.73.69.177:61575) State ROUTING going to sleep
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:470 (sofia/sipinterface_1/104@116.73.69.177:61575) Running State Change CS_CONSUME_MEDIA
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:545 (sofia/sipinterface_1/104@116.73.69.177:61575) State CONSUME_MEDIA
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_state_machine.c:545 (sofia/sipinterface_1/104@116.73.69.177:61575) State CONSUME_MEDIA going to sleep
- 2015-02-18 10:50:39.920767 [DEBUG] switch_core_session.c:1052 Send signal sofia/sipinterface_1/104@116.73.69.177:61575 [BREAK]
- 2015-02-18 10:50:39.920767 [DEBUG] sofia.c:6413 Channel sofia/sipinterface_1/104@116.73.69.177:61575 entering state [calling][0]
- send 3007 bytes to tls/[192.99.2.170]:5061 at 10:50:39.941818:
- ------------------------------------------------------------------------
- INVITE sip:104@116.73.69.177:61575;transport=TLS SIP/2.0
- Via: SIP/2.0/TLS 192.99.2.226:11001;branch=z9hG4bKFUj7118QN0yrF
- Route: <sip:192.99.2.170:5061>
- Max-Forwards: 49
- From: "David Johnson" <sip:+17187637958@revolt.revoltcloud.com>;tag=Xyag0QH690gmB
- To: <sip:104@116.73.69.177:61575;transport=TLS>
- Call-ID: e34323ba-b785-11e4-8202-135f369896d1
- CSeq: 71801255 INVITE
- Contact: <sip:mod_sofia@192.99.2.226:11001;transport=tls>
- User-Agent: 2600hz
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Content-Type: application/sdp
- Content-Disposition: session
- Content-Length: 1981
- X-AUTH-IP: 100.38.128.26
- X-FS-Support: update_display,send_info
- Remote-Party-ID: "David Johnson" <sip:+17187637958@revolt.revoltcloud.com>;party=calling;screen=yes;privacy=off
- v=0
- o=FreeSWITCH 1424252995 1424252996 IN IP4 192.99.2.226
- s=FreeSWITCH
- c=IN IP4 192.99.2.226
- t=0 0
- m=audio 21644 RTP/SAVP 0 101 13
- a=rtpmap:0 PCMU/8000
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=crypto:1 AEAD_AES_256_GCM_8 inline:Qf5lfNuEAiUEwk6J6gsdqsltRGJKDZBgSYeZAGpzum0H9Ffogc0Ws8+nq38
- a=crypto:2 AEAD_AES_128_GCM_8 inline:NHiLaL55HAk4OtJSWT7OlAeuADeFPeJYfMiBmw
- a=crypto:3 AES_CM_256_HMAC_SHA1_80 inline:ptxYythiwqlgxZ5sj4oIrUtJ18280ASIyFHIqLVNfN1n14dvOj9yETYdBLUD6w
- a=crypto:4 AES_CM_192_HMAC_SHA1_80 inline:xDYs+w8XgE6NjL1hjkO16drbhlzKcZYzY2INqfeE3jv6I31zfgE
- a=crypto:5 AES_CM_128_HMAC_SHA1_80 inline:CAi+0HgwbwmUtCYueVBAoDTQVyCiEtlJQSFukua8
- a=crypto:6 AES_CM_256_HMAC_SHA1_32 inline:qbyH4F0I7tAsUe6UndfsEhBWiciCqOsoKqMvrI8KT4xu5Dgm3CYY1qY786fK9A
- a=crypto:7 AES_CM_192_HMAC_SHA1_32 inline:OZv2QvACSixxHeqEAytFI5Z5BfhjMSoviSHPJTuXmHcFekjK/Uc
- a=crypto:8 AES_CM_128_HMAC_SHA1_32 inline:mtMTznAWm5UwV3jgUN7qM9j8uLC4P+YFGahy0ASD
- a=crypto:9 AES_CM_128_NULL_AUTH inline:kRbtb62SsOpd9oehkTBd5gqgq65TBWpuUWqLtsfh
- a=ptime:20
- m=video 22732 RTP/SAVP 98 34 31
- a=rtpmap:98 H264/90000
- a=rtpmap:34 H263/90000
- a=rtpmap:31 H261/90000
- a=crypto:1 AEAD_AES_256_GCM_8 inline:Vy5ZzLT7Ahr6GoTohFaLi7HclCL8M7nIl+jN4LjTikL0VGW/+BVJlIgnxuc
- a=crypto:2 AEAD_AES_128_GCM_8 inline:BZBZK90pZgoLic4RQYsnlbCURe3QHsHGFBDJZw
- a=crypto:3 AES_CM_256_HMAC_SHA1_80 inline:hTIhKGf7AyWNtxHPvEmWU/a9XmMmv5qsHdTZyekibL/gjJqf59kfTSzoEfbM7A
- a=crypto:4 AES_CM_192_HMAC_SHA1_80 inline:ILm9DDH4nJl5WpizJIX3pWdFHSlVma7rTaU2JV/0ZW8LdlERiGk
- a=crypto:5 AES_CM_128_HMAC_SHA1_80 inline:MT1QQa6e9jTBZrKJu0H4rEjIMLdAY08EIWFbmry0
- a=crypto:6 AES_CM_256_HMAC_SHA1_32 inline:+y200iDzJn67J8Ev9E6lC/KR71IwVxmR18TDikIi3LROsvdDaBQY0DoiCGlfsg
- a=crypto:7 AES_CM_192_HMAC_SHA1_32 inline:vO5RJ6mECsSkCzJPlHMfvdXrA95ZYh5K+00DgUlThI8oqz/MdIg
- a=crypto:8 AES_CM_128_HMAC_SHA1_32 inline:k/tD51oKgZlJ6IjSapD+EkZstZA6izI1jFKbELl8
- a=crypto:9 AES_CM_128_NULL_AUTH inline:UwFBxm8/HtMYmFrPYgaRvKTSzwUN6o7alFWnJmyh
- ------------------------------------------------------------------------
- recv 333 bytes from tls/[192.99.2.170]:5061 at 10:50:39.943511:
- ------------------------------------------------------------------------
- SIP/2.0 100 Attempting to connect your call
- Via: SIP/2.0/TLS 192.99.2.226:11001;branch=z9hG4bKFUj7118QN0yrF
- From: "David Johnson" <sip:+17187637958@revolt.revoltcloud.com>;tag=Xyag0QH690gmB
- To: <sip:104@116.73.69.177:61575;transport=TLS>
- Call-ID: e34323ba-b785-11e4-8202-135f369896d1
- CSeq: 71801255 INVITE
- Content-Length: 0
- ------------------------------------------------------------------------
- 2015-02-18 10:50:40.000759 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.2086.264>
- 2015-02-18 10:50:40.000759 [INFO] kazoo_node.c:625 exec: uuid_setvar_multi(e34323ba-b785-11e4-8202-135f369896d1 ecallmgr_Channel-Authorized=true;ecallmgr_Account-ID=e5ef4eef7ac70533b19c803b35d6a10d)
- 2015-02-18 10:50:40.000759 [DEBUG] kazoo_event_stream.c:242 increased event stream buffer size to 4941
- 2015-02-18 10:50:40.000759 [DEBUG] kazoo_event_stream.c:242 increased event stream buffer size to 4941
- 2015-02-18 10:50:40.200766 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.2120.264>
- recv 368 bytes from tls/[192.99.2.170]:5061 at 10:50:40.267622:
- ------------------------------------------------------------------------
- SIP/2.0 415 Unsupported Media Type
- Via: SIP/2.0/TLS 192.99.2.226:11001;branch=z9hG4bKFUj7118QN0yrF
- To: <sip:104@116.73.69.177:61575;transport=TLS>;tag=954d5837
- From: "David Johnson"<sip:+17187637958@revolt.revoltcloud.com>;tag=Xyag0QH690gmB
- Call-ID: e34323ba-b785-11e4-8202-135f369896d1
- CSeq: 71801255 INVITE
- User-Agent: Z 3.6.25251 r25476
- Content-Length: 0
- ------------------------------------------------------------------------
- send 403 bytes to tls/[192.99.2.170]:5061 at 10:50:40.267735:
- ------------------------------------------------------------------------
- ACK sip:104@116.73.69.177:61575;transport=TLS SIP/2.0
- Via: SIP/2.0/TLS 192.99.2.226:11001;branch=z9hG4bKFUj7118QN0yrF
- Route: <sip:192.99.2.170:5061>
- Max-Forwards: 49
- From: "David Johnson" <sip:+17187637958@revolt.revoltcloud.com>;tag=Xyag0QH690gmB
- To: <sip:104@116.73.69.177:61575;transport=TLS>;tag=954d5837
- Call-ID: e34323ba-b785-11e4-8202-135f369896d1
- CSeq: 71801255 ACK
- Content-Length: 0
- ------------------------------------------------------------------------
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_session.c:1052 Send signal sofia/sipinterface_1/104@116.73.69.177:61575 [BREAK]
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_session.c:1052 Send signal sofia/sipinterface_1/104@116.73.69.177:61575 [BREAK]
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_session.c:1052 Send signal sofia/sipinterface_1/104@116.73.69.177:61575 [BREAK]
- 2015-02-18 10:50:40.260769 [DEBUG] sofia.c:6413 Channel sofia/sipinterface_1/104@116.73.69.177:61575 entering state [terminated][415]
- 2015-02-18 10:50:40.260769 [NOTICE] sofia.c:7299 Hangup sofia/sipinterface_1/104@116.73.69.177:61575 [CS_CONSUME_MEDIA] [SERVICE_NOT_IMPLEMENTED]
- 2015-02-18 10:50:40.260769 [DEBUG] switch_channel.c:3217 Send signal sofia/sipinterface_1/104@116.73.69.177:61575 [KILL]
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_session.c:1387 Send signal sofia/sipinterface_1/104@116.73.69.177:61575 [BREAK]
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_state_machine.c:470 (sofia/sipinterface_1/104@116.73.69.177:61575) Running State Change CS_HANGUP
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_state_machine.c:733 (sofia/sipinterface_1/104@116.73.69.177:61575) Callstate Change DOWN -> HANGUP
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_state_machine.c:735 (sofia/sipinterface_1/104@116.73.69.177:61575) State HANGUP
- 2015-02-18 10:50:40.260769 [DEBUG] mod_sofia.c:413 Channel sofia/sipinterface_1/104@116.73.69.177:61575 hanging up, cause: SERVICE_NOT_IMPLEMENTED
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_state_machine.c:58 sofia/sipinterface_1/104@116.73.69.177:61575 Standard HANGUP, cause: SERVICE_NOT_IMPLEMENTED
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_state_machine.c:735 (sofia/sipinterface_1/104@116.73.69.177:61575) State HANGUP going to sleep
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_state_machine.c:502 (sofia/sipinterface_1/104@116.73.69.177:61575) State Change CS_HANGUP -> CS_REPORTING
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_session.c:1387 Send signal sofia/sipinterface_1/104@116.73.69.177:61575 [BREAK]
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_state_machine.c:470 (sofia/sipinterface_1/104@116.73.69.177:61575) Running State Change CS_REPORTING
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_state_machine.c:821 (sofia/sipinterface_1/104@116.73.69.177:61575) State REPORTING
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_state_machine.c:102 sofia/sipinterface_1/104@116.73.69.177:61575 Standard REPORTING, cause: SERVICE_NOT_IMPLEMENTED
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_state_machine.c:821 (sofia/sipinterface_1/104@116.73.69.177:61575) State REPORTING going to sleep
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_state_machine.c:496 (sofia/sipinterface_1/104@116.73.69.177:61575) State Change CS_REPORTING -> CS_DESTROY
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_session.c:1387 Send signal sofia/sipinterface_1/104@116.73.69.177:61575 [BREAK]
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_session.c:1614 Session 2 (sofia/sipinterface_1/104@116.73.69.177:61575) Locked, Waiting on external entities
- 2015-02-18 10:50:40.260769 [DEBUG] switch_ivr_originate.c:3695 Originate Resulted in Error Cause: 79 [SERVICE_NOT_IMPLEMENTED]
- 2015-02-18 10:50:40.260769 [NOTICE] switch_core_session.c:1632 Session 2 (sofia/sipinterface_1/104@116.73.69.177:61575) Ended
- 2015-02-18 10:50:40.260769 [NOTICE] switch_core_session.c:1636 Close Channel sofia/sipinterface_1/104@116.73.69.177:61575 [CS_DESTROY]
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_state_machine.c:624 (sofia/sipinterface_1/104@116.73.69.177:61575) Running State Change CS_DESTROY
- 2015-02-18 10:50:40.260769 [INFO] mod_dptools.c:3277 Originate Failed. Cause: SERVICE_NOT_IMPLEMENTED
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_state_machine.c:634 (sofia/sipinterface_1/104@116.73.69.177:61575) State DESTROY
- 2015-02-18 10:50:40.260769 [DEBUG] mod_sofia.c:323 sofia/sipinterface_1/104@116.73.69.177:61575 SOFIA DESTROY
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_state_machine.c:109 sofia/sipinterface_1/104@116.73.69.177:61575 Standard DESTROY
- 2015-02-18 10:50:40.260769 [DEBUG] switch_core_state_machine.c:634 (sofia/sipinterface_1/104@116.73.69.177:61575) State DESTROY going to sleep
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com event(Event-Name=CUSTOM,Event-Subclass=whistle::masquerade,whistle_event_name=CHANNEL_EXECUTE_COMPLETE,whistle_application_name=bridge)
- 2015-02-18 10:50:40.260769 [DEBUG] kazoo_event_stream.c:242 increased event stream buffer size to 5082
- 2015-02-18 10:50:40.260769 [DEBUG] kazoo_event_stream.c:242 increased event stream buffer size to 5082
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com park()
- 2015-02-18 10:50:40.280760 [NOTICE] kazoo_node.c:285 log|ppF_pmaC4dt1uXp-2_KLbA..|executing answer
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_session.c:1187 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_ivr.c:614 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Command Execute answer()
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com answer()
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:1185 looking for crypto suite [AEAD_AES_256_GCM_8] in [1 AES_CM_128_HMAC_SHA1_80 inline:g6pJL/yWKnwewA+jQEG900eSXoOLy3FOJvyvioyn]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:1185 looking for crypto suite [AEAD_AES_128_GCM_8] in [1 AES_CM_128_HMAC_SHA1_80 inline:g6pJL/yWKnwewA+jQEG900eSXoOLy3FOJvyvioyn]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:1185 looking for crypto suite [AES_CM_256_HMAC_SHA1_80] in [1 AES_CM_128_HMAC_SHA1_80 inline:g6pJL/yWKnwewA+jQEG900eSXoOLy3FOJvyvioyn]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:1185 looking for crypto suite [AES_CM_192_HMAC_SHA1_80] in [1 AES_CM_128_HMAC_SHA1_80 inline:g6pJL/yWKnwewA+jQEG900eSXoOLy3FOJvyvioyn]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:1185 looking for crypto suite [AES_CM_128_HMAC_SHA1_80] in [1 AES_CM_128_HMAC_SHA1_80 inline:g6pJL/yWKnwewA+jQEG900eSXoOLy3FOJvyvioyn]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:1190 Found suite AES_CM_128_HMAC_SHA1_80
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:1256 Set Remote Key [1 AES_CM_128_HMAC_SHA1_80 inline:g6pJL/yWKnwewA+jQEG900eSXoOLy3FOJvyvioyn]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:922 Set Local audio crypto Key [1 AES_CM_128_HMAC_SHA1_80 inline:lh8dGRcj3XIy3IMf4/RUzjp3mtJUWGEDLsIDEtwj]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:3474 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[opus:116:48000:20:0:1]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:3474 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G7221:115:32000:20:48000:1]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:3474 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G7221:107:16000:20:32000:1]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:3474 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[G722:9:8000:20:64000:1]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:3474 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMU:0:8000:20:64000:1]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:3528 Audio Codec Compare [PCMU:0:8000:20:64000:1] ++++ is saved as a match
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:3474 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[PCMA:8:8000:20:64000:1]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:3474 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[GSM:3:8000:20:13200:1]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:3474 Audio Codec Compare [PCMU:0:8000:20:64000:1]/[SPEEX:99:8000:20:24600:1]
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:3395 Set telephone-event payload to 101
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:2352 Set Codec sofia/sipinterface_1/davidcell@revolt.revoltcloud.com PCMU/8000 20 ms 160 samples 64000 bits 1 channels
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_codec.c:111 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Original read codec set to PCMU:0
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:3719 Set 2833 dtmf send/recv payload to 101
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:4939 AUDIO RTP [sofia/sipinterface_1/davidcell@revolt.revoltcloud.com] 192.99.2.226 port 31342 -> 100.38.128.26 port 52734 codec: 0 ms: 20
- 2015-02-18 10:50:40.280760 [DEBUG] switch_rtp.c:3383 Starting timer [soft] 160 bytes per 20ms
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:5287 Set 2833 dtmf send payload to 101
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_media.c:5293 Set 2833 dtmf receive payload to 101
- 2015-02-18 10:50:40.280760 [INFO] switch_rtp.c:3200 Activating Audio Secure RTP SEND
- 2015-02-18 10:50:40.280760 [INFO] switch_rtp.c:3178 Activating Audio Secure RTP RECV
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_sqldb.c:2568 Secure Type: srtp:sdes:AES_CM_128_HMAC_SHA1_80
- 2015-02-18 10:50:40.280760 [NOTICE] sofia_media.c:92 Pre-Answer sofia/sipinterface_1/davidcell@revolt.revoltcloud.com!
- 2015-02-18 10:50:40.280760 [DEBUG] switch_core_sqldb.c:2568 Secure Type: srtp:sdes:AES_CM_128_HMAC_SHA1_80
- 2015-02-18 10:50:40.280760 [DEBUG] switch_channel.c:3394 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) Callstate Change RINGING -> EARLY
- 2015-02-18 10:50:40.280760 [DEBUG] mod_sofia.c:785 Local SDP sofia/sipinterface_1/davidcell@revolt.revoltcloud.com:
- v=0
- o=FreeSWITCH 1424243298 1424243299 IN IP4 192.99.2.226
- s=FreeSWITCH
- c=IN IP4 192.99.2.226
- t=0 0
- m=audio 31342 RTP/SAVP 0 101
- a=rtpmap:0 PCMU/8000
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=ptime:20
- a=sendrecv
- a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:lh8dGRcj3XIy3IMf4/RUzjp3mtJUWGEDLsIDEtwj
- 2015-02-18 10:50:40.300759 [DEBUG] switch_core_session.c:907 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:40.300759 [NOTICE] mod_dptools.c:1258 Channel [sofia/sipinterface_1/davidcell@revolt.revoltcloud.com] has been answered
- send 1411 bytes to udp/[192.99.2.170]:5060 at 10:50:40.301003:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.99.2.170;branch=z9hG4bKfad6.848ab8d3.0;i=2955
- Via: SIP/2.0/TLS 100.38.128.26:38715;branch=z9hG4bK-524287-1---2ebb89807096d777;rport=38715
- Record-Route: <sip:192.99.2.170;r2=on;lr=on;ftag=5794f71e>
- Record-Route: <sip:192.99.2.170:5061;transport=tls;r2=on;lr=on;ftag=5794f71e>
- From: "17187637958"<sip:davidcell@revolt.revoltcloud.com;transport=TLS>;tag=5794f71e
- To: <sip:104@revolt.revoltcloud.com;transport=TLS>;tag=vNHQyv02crt1F
- Call-ID: ppF_pmaC4dt1uXp-2_KLbA..
- CSeq: 2 INVITE
- Contact: <sip:104@192.99.2.226:11000;transport=udp>
- User-Agent: 2600hz
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Content-Type: application/sdp
- Content-Disposition: session
- Content-Length: 305
- Remote-Party-ID: "104" <sip:104@revolt.revoltcloud.com>;party=calling;privacy=off;screen=no
- v=0
- o=FreeSWITCH 1424243298 1424243299 IN IP4 192.99.2.226
- s=FreeSWITCH
- c=IN IP4 192.99.2.226
- t=0 0
- m=audio 31342 RTP/SAVP 0 101
- a=rtpmap:0 PCMU/8000
- a=rtpmap:101 telephone-event/8000
- a=fmtp:101 0-16
- a=ptime:20
- a=crypto:1 AES_CM_128_HMAC_SHA1_80 inline:lh8dGRcj3XIy3IMf4/RUzjp3mtJUWGEDLsIDEtwj
- ------------------------------------------------------------------------
- 2015-02-18 10:50:40.300759 [DEBUG] switch_core_session.c:1052 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:40.300759 [DEBUG] switch_channel.c:3684 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) Callstate Change EARLY -> ACTIVE
- 2015-02-18 10:50:40.300759 [DEBUG] sofia.c:6413 Channel sofia/sipinterface_1/davidcell@revolt.revoltcloud.com entering state [completed][200]
- 2015-02-18 10:50:40.300759 [DEBUG] switch_ivr.c:961 Codec Activated L16@8000hz 1 channels 20ms
- recv 565 bytes from udp/[192.99.2.170]:5060 at 10:50:40.420932:
- ------------------------------------------------------------------------
- ACK sip:104@192.99.2.226:11000;transport=udp SIP/2.0
- Via: SIP/2.0/UDP 192.99.2.170;branch=z9hG4bKcydzigwkX;i=2955
- Via: SIP/2.0/TLS 100.38.128.26:38715;branch=z9hG4bK-524287-1---5e3350ad23e140fa;rport=38715
- Max-Forwards: 50
- Contact: <sip:davidcell@100.38.128.26:38715;transport=TLS>
- To: <sip:104@revolt.revoltcloud.com;transport=TLS>;tag=vNHQyv02crt1F
- From: "17187637958"<sip:davidcell@revolt.revoltcloud.com;transport=TLS>;tag=5794f71e
- Call-ID: ppF_pmaC4dt1uXp-2_KLbA..
- CSeq: 2 ACK
- User-Agent: Zoiper r29567
- Content-Length: 0
- X-AUTH-IP: 100.38.128.26
- ------------------------------------------------------------------------
- 2015-02-18 10:50:40.420770 [DEBUG] switch_core_session.c:1052 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:40.420770 [DEBUG] switch_core_session.c:1052 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:40.420770 [DEBUG] switch_core_session.c:1052 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:40.420770 [DEBUG] sofia.c:6413 Channel sofia/sipinterface_1/davidcell@revolt.revoltcloud.com entering state [ready][200]
- 2015-02-18 10:50:40.480781 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.2086.264>
- 2015-02-18 10:50:40.480781 [INFO] kazoo_node.c:625 exec: uuid_setvar(ppF_pmaC4dt1uXp-2_KLbA.. playback_terminators #*0123456789)
- span class="re2"> span class="re2"> 2015-02-18 10:50:40.580767 [DEBUG] switch_rtp.c:5617 Correct ip/port confirmed.
- 2015-02-18 10:50:40.680779 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.2086.264>
- 2015-02-18 10:50:40.700779 [NOTICE] kazoo_node.c:285 log|ppF_pmaC4dt1uXp-2_KLbA..|executing playback ${http_get(http://127.0.0.1:15984/system_media/vm-person/vm-person.wav)}
- 2015-02-18 10:50:40.700779 [DEBUG] switch_core_session.c:1187 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:40.700779 [DEBUG] switch_ivr.c:614 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Command Execute playback(${http_get(http://127.0.0.1:15984/system_media/vm-person/vm-person.wav)})
- 2015-02-18 10:50:40.700779 [DEBUG] mod_http_cache.c:523 Locked cache
- 2015-02-18 10:50:40.700779 [INFO] mod_http_cache.c:606 Cache MISS: size = 0 (0 MB), hit ratio = 0/1
- 2015-02-18 10:50:40.700779 [DEBUG] mod_http_cache.c:671 Adding http://127.0.0.1:15984/system_media/vm-person/vm-person.wav(/usr/share/freeswitch/http_cache/e3/bb3008-b785-11e4-820a-135f369896d1.wav) to cache index 0
- 2015-02-18 10:50:40.700779 [DEBUG] mod_http_cache.c:534 Unlocked cache
- 2015-02-18 10:50:40.700779 [DEBUG] mod_http_cache.c:971 opening /usr/share/freeswitch/http_cache/e3/bb3008-b785-11e4-820a-135f369896d1.wav for URL cache
- 2015-02-18 10:50:40.720771 [DEBUG] mod_http_cache.c:504 HTTP/1.1 200 OK
- 2015-02-18 10:50:40.720771 [DEBUG] mod_http_cache.c:504 Server: CouchDB/1.1.1 (Erlang OTP/R15B03)
- 2015-02-18 10:50:40.720771 [DEBUG] mod_http_cache.c:504 ETag: "2-5624de65626e1032348f1baf226a982c"
- 2015-02-18 10:50:40.720771 [DEBUG] mod_http_cache.c:504 Date: Wed, 18 Feb 2015 15:51:06 GMT
- 2015-02-18 10:50:40.720771 [DEBUG] mod_http_cache.c:504 Content-Type: audio/x-wav
- 2015-02-18 10:50:40.720771 [DEBUG] mod_http_cache.c:504 Content-MD5: +fnuLGvHNc8Hvth5hivgnQ==
- 2015-02-18 10:50:40.720771 [DEBUG] mod_http_cache.c:504 Content-Length: 51884
- 2015-02-18 10:50:40.720771 [DEBUG] mod_http_cache.c:504 Cache-Control: must-revalidate
- 2015-02-18 10:50:40.720771 [DEBUG] mod_http_cache.c:504 Accept-Ranges: bytes
- 2015-02-18 10:50:40.720771 [DEBUG] mod_http_cache.c:504
- 2015-02-18 10:50:40.720771 [INFO] mod_http_cache.c:1012 URL http://127.0.0.1:15984/system_media/vm-person/vm-person.wav downloaded in 9 ms
- 2015-02-18 10:50:40.720771 [DEBUG] mod_http_cache.c:523 Locked cache
- 2015-02-18 10:50:40.720771 [DEBUG] mod_http_cache.c:534 Unlocked cache
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com playback(/usr/share/freeswitch/http_cache/e3/bb3008-b785-11e4-820a-135f369896d1.wav)
- 2015-02-18 10:50:40.720771 [DEBUG] switch_core_file.c:216 File /usr/share/freeswitch/http_cache/e3/bb3008-b785-11e4-820a-135f369896d1.wav sample rate 16000 doesn't match requested rate 8000
- 2015-02-18 10:50:40.720771 [DEBUG] switch_ivr_play_say.c:1306 Codec Activated L16@8000hz 1 channels 20ms
- 2015-02-18 10:50:40.900779 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.2086.264>
- recv 309 bytes from udp/[198.27.82.183]:5060 at 10:50:40.988329:
- ------------------------------------------------------------------------
- OPTIONS sip:192.99.2.226:11000 SIP/2.0
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bK2cdb.50b2d4c4.0
- To: sip:192.99.2.226:11000
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-369b
- CSeq: 10 OPTIONS
- Call-ID: 7ce9b06349acd7bb-6746@198.27.82.183
- Max-Forwards: 70
- Content-Length: 0
- ------------------------------------------------------------------------
- send 675 bytes to udp/[198.27.82.183]:5060 at 10:50:40.988440:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bK2cdb.50b2d4c4.0
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-369b
- To: <sip:192.99.2.226:11000>;tag=rHcmQgXmrm1pH
- Call-ID: 7ce9b06349acd7bb-6746@198.27.82.183
- CSeq: 10 OPTIONS
- Contact: <sip:192.99.2.226:11000>
- User-Agent: 2600hz
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 307 bytes from udp/[192.99.2.170]:5060 at 10:50:41.835347:
- ------------------------------------------------------------------------
- OPTIONS sip:192.99.2.226:11000 SIP/2.0
- Via: SIP/2.0/UDP 192.99.2.170;branch=z9hG4bK1579.02f10e77.0
- To: sip:192.99.2.226:11000
- From: sip:sipcheck@192.99.2.170;tag=a0a22de2d04cc628907fa97ec15a84d0-4abb
- CSeq: 10 OPTIONS
- Call-ID: 51fae4ba5462350d-31432@192.99.2.170
- Max-Forwards: 70
- Content-Length: 0
- ------------------------------------------------------------------------
- send 673 bytes to udp/[192.99.2.170]:5060 at 10:50:41.835671:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.99.2.170;branch=z9hG4bK1579.02f10e77.0
- From: sip:sipcheck@192.99.2.170;tag=a0a22de2d04cc628907fa97ec15a84d0-4abb
- To: <sip:192.99.2.226:11000>;tag=y7381j296966p
- Call-ID: 51fae4ba5462350d-31432@192.99.2.170
- CSeq: 10 OPTIONS
- Contact: <sip:192.99.2.226:11000>
- User-Agent: 2600hz
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Content-Length: 0
- ------------------------------------------------------------------------
- 2015-02-18 10:50:42.320799 [DEBUG] switch_ivr_play_say.c:1715 done playing file /usr/share/freeswitch/http_cache/e3/bb3008-b785-11e4-820a-135f369896d1.wav
- 2015-02-18 10:50:42.340765 [NOTICE] kazoo_node.c:285 log|ppF_pmaC4dt1uXp-2_KLbA..|executing say en name_spelled pronounced 5004
- 2015-02-18 10:50:42.340765 [DEBUG] switch_core_session.c:1187 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:42.340765 [DEBUG] switch_ivr.c:614 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Command Execute say(en name_spelled pronounced 5004 )
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com say(en name_spelled pronounced 5004 )
- 2015-02-18 10:50:42.360782 [DEBUG] switch_core_file.c:216 File /usr/share/freeswitch/sounds/en/us/callie/digits/5.wav sample rate 16000 doesn't match requested rate 8000
- 2015-02-18 10:50:42.360782 [DEBUG] switch_ivr_play_say.c:1306 Codec Activated L16@8000hz 1 channels 20ms
- 2015-02-18 10:50:42.540791 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.2086.264>
- recv 309 bytes from udp/[198.27.82.183]:5060 at 10:50:42.988331:
- ------------------------------------------------------------------------
- OPTIONS sip:192.99.2.226:11000 SIP/2.0
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bK21eb.5a6d9b73.0
- To: sip:192.99.2.226:11000
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-531e
- CSeq: 10 OPTIONS
- Call-ID: 7ce9b06349acd7b9-6746@198.27.82.183
- Max-Forwards: 70
- Content-Length: 0
- ------------------------------------------------------------------------
- send 675 bytes to udp/[198.27.82.183]:5060 at 10:50:42.988435:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bK21eb.5a6d9b73.0
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-531e
- To: <sip:192.99.2.226:11000>;tag=pZS2KtUDy2mHa
- Call-ID: 7ce9b06349acd7b9-6746@198.27.82.183
- CSeq: 10 OPTIONS
- Contact: <sip:192.99.2.226:11000>
- User-Agent: 2600hz
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 309 bytes from udp/[198.27.82.183]:5060 at 10:50:42.988504:
- ------------------------------------------------------------------------
- OPTIONS sip:192.99.2.226:11000 SIP/2.0
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bKcbdb.e4795e65.0
- To: sip:192.99.2.226:11000
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-5ba6
- CSeq: 10 OPTIONS
- Call-ID: 7ce9b06349acd7bd-6746@198.27.82.183
- Max-Forwards: 70
- Content-Length: 0
- ------------------------------------------------------------------------
- send 675 bytes to udp/[198.27.82.183]:5060 at 10:50:42.988573:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bKcbdb.e4795e65.0
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-5ba6
- To: <sip:192.99.2.226:11000>;tag=t3y5t6yUj6Dvr
- Call-ID: 7ce9b06349acd7bd-6746@198.27.82.183
- CSeq: 10 OPTIONS
- Contact: <sip:192.99.2.226:11000>
- User-Agent: 2600hz
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Content-Length: 0
- ------------------------------------------------------------------------
- 2015-02-18 10:50:43.200766 [DEBUG] switch_core_file.c:216 File /usr/share/freeswitch/sounds/en/us/callie/digits/0.wav sample rate 16000 doesn't match requested rate 8000
- 2015-02-18 10:50:43.840766 [DEBUG] switch_core_file.c:216 File /usr/share/freeswitch/sounds/en/us/callie/digits/0.wav sample rate 16000 doesn't match requested rate 8000
- 2015-02-18 10:50:44.500779 [DEBUG] switch_core_file.c:216 File /usr/share/freeswitch/sounds/en/us/callie/digits/4.wav sample rate 16000 doesn't match requested rate 8000
- recv 309 bytes from udp/[198.27.82.183]:5060 at 10:50:44.988336:
- ------------------------------------------------------------------------
- OPTIONS sip:192.99.2.226:11000 SIP/2.0
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bK2cdb.50b2d4c4.0
- To: sip:192.99.2.226:11000
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-369b
- CSeq: 10 OPTIONS
- Call-ID: 7ce9b06349acd7bb-6746@198.27.82.183
- Max-Forwards: 70
- Content-Length: 0
- ------------------------------------------------------------------------
- send 675 bytes to udp/[198.27.82.183]:5060 at 10:50:44.988433:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bK2cdb.50b2d4c4.0
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-369b
- To: <sip:192.99.2.226:11000>;tag=rHcmQgXmrm1pH
- Call-ID: 7ce9b06349acd7bb-6746@198.27.82.183
- CSeq: 10 OPTIONS
- Contact: <sip:192.99.2.226:11000>
- User-Agent: 2600hz
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Content-Length: 0
- ------------------------------------------------------------------------
- 2015-02-18 10:50:45.200766 [DEBUG] switch_ivr_play_say.c:1715 done playing file file_string://digits/5.wav!digits/0.wav!digits/0.wav!digits/4.wav
- 2015-02-18 10:50:45.220764 [NOTICE] kazoo_node.c:285 log|ppF_pmaC4dt1uXp-2_KLbA..|executing playback ${http_get(http://127.0.0.1:15984/system_media/vm-not_available/vm-not_available.wav)}
- 2015-02-18 10:50:45.220764 [DEBUG] switch_core_session.c:1187 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:45.220764 [DEBUG] switch_ivr.c:614 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Command Execute playback(${http_get(http://127.0.0.1:15984/system_media/vm-not_available/vm-not_available.wav)})
- 2015-02-18 10:50:45.220764 [DEBUG] mod_http_cache.c:523 Locked cache
- 2015-02-18 10:50:45.220764 [INFO] mod_http_cache.c:606 Cache MISS: size = 1 (0 MB), hit ratio = 0/2
- 2015-02-18 10:50:45.220764 [DEBUG] mod_http_cache.c:671 Adding http://127.0.0.1:15984/system_media/vm-not_available/vm-not_available.wav(/usr/share/freeswitch/http_cache/e6/6d0df8-b785-11e4-820d-135f369896d1.wav) to cache index 1
- 2015-02-18 10:50:45.220764 [DEBUG] mod_http_cache.c:534 Unlocked cache
- 2015-02-18 10:50:45.220764 [DEBUG] mod_http_cache.c:971 opening /usr/share/freeswitch/http_cache/e6/6d0df8-b785-11e4-820d-135f369896d1.wav for URL cache
- 2015-02-18 10:50:45.240772 [DEBUG] mod_http_cache.c:504 HTTP/1.1 200 OK
- 2015-02-18 10:50:45.240772 [DEBUG] mod_http_cache.c:504 Server: CouchDB/1.1.1 (Erlang OTP/R15B03)
- 2015-02-18 10:50:45.240772 [DEBUG] mod_http_cache.c:504 ETag: "2-38f10c56542175af215ae3ca870076b5"
- 2015-02-18 10:50:45.240772 [DEBUG] mod_http_cache.c:504 Date: Wed, 18 Feb 2015 15:50:44 GMT
- 2015-02-18 10:50:45.240772 [DEBUG] mod_http_cache.c:504 Content-Type: audio/x-wav
- 2015-02-18 10:50:45.240772 [DEBUG] mod_http_cache.c:504 Content-MD5: QOGTHTA+sxoEVXji1C9H4w==
- 2015-02-18 10:50:45.240772 [DEBUG] mod_http_cache.c:504 Content-Length: 35756
- 2015-02-18 10:50:45.240772 [DEBUG] mod_http_cache.c:504 Cache-Control: must-revalidate
- 2015-02-18 10:50:45.240772 [DEBUG] mod_http_cache.c:504 Accept-Ranges: bytes
- 2015-02-18 10:50:45.240772 [DEBUG] mod_http_cache.c:504
- 2015-02-18 10:50:45.240772 [INFO] mod_http_cache.c:1012 URL http://127.0.0.1:15984/system_media/vm-not_available/vm-not_available.wav downloaded in 8 ms
- 2015-02-18 10:50:45.240772 [DEBUG] mod_http_cache.c:523 Locked cache
- 2015-02-18 10:50:45.240772 [DEBUG] mod_http_cache.c:534 Unlocked cache
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com playback(/usr/share/freeswitch/http_cache/e6/6d0df8-b785-11e4-820d-135f369896d1.wav)
- 2015-02-18 10:50:45.240772 [DEBUG] switch_core_file.c:216 File /usr/share/freeswitch/http_cache/e6/6d0df8-b785-11e4-820d-135f369896d1.wav sample rate 16000 doesn't match requested rate 8000
- 2015-02-18 10:50:45.240772 [DEBUG] switch_ivr_play_say.c:1306 Codec Activated L16@8000hz 1 channels 20ms
- 2015-02-18 10:50:45.420780 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.2086.264>
- recv 309 bytes from udp/[198.27.82.183]:5060 at 10:50:45.494313:
- ------------------------------------------------------------------------
- OPTIONS sip:192.99.2.226:11000 SIP/2.0
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bKebdb.92f545d7.0
- To: sip:192.99.2.226:11000
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-80cd
- CSeq: 10 OPTIONS
- Call-ID: 7ce9b06349acd7bf-6746@198.27.82.183
- Max-Forwards: 70
- Content-Length: 0
- ------------------------------------------------------------------------
- send 675 bytes to udp/[198.27.82.183]:5060 at 10:50:45.494661:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bKebdb.92f545d7.0
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-80cd
- To: <sip:192.99.2.226:11000>;tag=ZgX13DKD4jXSj
- Call-ID: 7ce9b06349acd7bf-6746@198.27.82.183
- CSeq: 10 OPTIONS
- Contact: <sip:192.99.2.226:11000>
- User-Agent: 2600hz
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 309 bytes from udp/[198.27.82.183]:5060 at 10:50:45.988331:
- ------------------------------------------------------------------------
- OPTIONS sip:192.99.2.226:11000 SIP/2.0
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bKebdb.92f545d7.0
- To: sip:192.99.2.226:11000
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-80cd
- CSeq: 10 OPTIONS
- Call-ID: 7ce9b06349acd7bf-6746@198.27.82.183
- Max-Forwards: 70
- Content-Length: 0
- ------------------------------------------------------------------------
- send 675 bytes to udp/[198.27.82.183]:5060 at 10:50:45.988437:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bKebdb.92f545d7.0
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-80cd
- To: <sip:192.99.2.226:11000>;tag=ZgX13DKD4jXSj
- Call-ID: 7ce9b06349acd7bf-6746@198.27.82.183
- CSeq: 10 OPTIONS
- Contact: <sip:192.99.2.226:11000>
- User-Agent: 2600hz
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Content-Length: 0
- ------------------------------------------------------------------------
- 2015-02-18 10:50:46.340766 [DEBUG] switch_ivr_play_say.c:1715 done playing file /usr/share/freeswitch/http_cache/e6/6d0df8-b785-11e4-820d-135f369896d1.wav
- 2015-02-18 10:50:46.360763 [NOTICE] kazoo_node.c:285 log|ppF_pmaC4dt1uXp-2_KLbA..|executing event Event-Subclass=whistle::noop,Event-Name=CUSTOM,whistle_event_name=CHANNEL_EXECUTE_COMPLETE,whistle_application_name=noop,whistle_application_response=9fe6e8b46061d11805a1ccf3b7ca0f33
- 2015-02-18 10:50:46.360763 [DEBUG] switch_core_session.c:1187 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:46.360763 [DEBUG] switch_ivr.c:614 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Command Execute event(Event-Subclass=whistle::noop,Event-Name=CUSTOM,whistle_event_name=CHANNEL_EXECUTE_COMPLETE,whistle_application_name=noop,whistle_application_response=9fe6e8b46061d11805a1ccf3b7ca0f33)
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com event(Event-Subclass=whistle::noop,Event-Name=CUSTOM,whistle_event_name=CHANNEL_EXECUTE_COMPLETE,whistle_application_name=noop,whistle_application_response=9fe6e8b46061d11805a1ccf3b7ca0f33)
- 2015-02-18 10:50:46.560766 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.2086.264>
- 2015-02-18 10:50:46.560766 [NOTICE] kazoo_node.c:285 log|ppF_pmaC4dt1uXp-2_KLbA..|executing playback ${http_get(http://127.0.0.1:15984/system_media/vm-record_message/vm-record_message.wav)}
- 2015-02-18 10:50:46.560766 [DEBUG] switch_core_session.c:1187 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:46.560766 [DEBUG] switch_ivr.c:614 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Command Execute playback(${http_get(http://127.0.0.1:15984/system_media/vm-record_message/vm-record_message.wav)})
- 2015-02-18 10:50:46.560766 [DEBUG] mod_http_cache.c:523 Locked cache
- 2015-02-18 10:50:46.560766 [INFO] mod_http_cache.c:606 Cache MISS: size = 2 (0 MB), hit ratio = 0/3
- 2015-02-18 10:50:46.560766 [DEBUG] mod_http_cache.c:671 Adding http://127.0.0.1:15984/system_media/vm-record_message/vm-record_message.wav(/usr/share/freeswitch/http_cache/e7/395b92-b785-11e4-8210-135f369896d1.wav) to cache index 2
- 2015-02-18 10:50:46.560766 [DEBUG] mod_http_cache.c:534 Unlocked cache
- 2015-02-18 10:50:46.560766 [DEBUG] mod_http_cache.c:971 opening /usr/share/freeswitch/http_cache/e7/395b92-b785-11e4-8210-135f369896d1.wav for URL cache
- 2015-02-18 10:50:46.580771 [DEBUG] mod_http_cache.c:504 HTTP/1.1 200 OK
- 2015-02-18 10:50:46.580771 [DEBUG] mod_http_cache.c:504 Server: CouchDB/1.1.1 (Erlang OTP/R15B03)
- 2015-02-18 10:50:46.580771 [DEBUG] mod_http_cache.c:504 ETag: "2-572495d3cd8fca414aae3adab8c1abc3"
- 2015-02-18 10:50:46.580771 [DEBUG] mod_http_cache.c:504 Date: Wed, 18 Feb 2015 15:51:09 GMT
- 2015-02-18 10:50:46.580771 [DEBUG] mod_http_cache.c:504 Content-Type: audio/x-wav
- 2015-02-18 10:50:46.580771 [DEBUG] mod_http_cache.c:504 Content-MD5: vipgv1EJMILHBPrQONaG9Q==
- 2015-02-18 10:50:46.580771 [DEBUG] mod_http_cache.c:504 Content-Length: 153260
- 2015-02-18 10:50:46.580771 [DEBUG] mod_http_cache.c:504 Cache-Control: must-revalidate
- 2015-02-18 10:50:46.580771 [DEBUG] mod_http_cache.c:504 Accept-Ranges: bytes
- 2015-02-18 10:50:46.580771 [DEBUG] mod_http_cache.c:504
- 2015-02-18 10:50:46.580771 [INFO] mod_http_cache.c:1012 URL http://127.0.0.1:15984/system_media/vm-record_message/vm-record_message.wav downloaded in 18 ms
- 2015-02-18 10:50:46.580771 [DEBUG] mod_http_cache.c:523 Locked cache
- 2015-02-18 10:50:46.580771 [DEBUG] mod_http_cache.c:534 Unlocked cache
- EXECUTE sofia/sipinterface_1/davidcell@revolt.revoltcloud.com playback(/usr/share/freeswitch/http_cache/e7/395b92-b785-11e4-8210-135f369896d1.wav)
- 2015-02-18 10:50:46.580771 [DEBUG] switch_core_file.c:216 File /usr/share/freeswitch/http_cache/e7/395b92-b785-11e4-8210-135f369896d1.wav sample rate 16000 doesn't match requested rate 8000
- 2015-02-18 10:50:46.580771 [DEBUG] switch_ivr_play_say.c:1306 Codec Activated L16@8000hz 1 channels 20ms
- 2015-02-18 10:50:46.760770 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.2086.264>
- recv 309 bytes from udp/[198.27.82.183]:5060 at 10:50:46.988318:
- ------------------------------------------------------------------------
- OPTIONS sip:192.99.2.226:11000 SIP/2.0
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bKcbdb.e4795e65.0
- To: sip:192.99.2.226:11000
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-5ba6
- CSeq: 10 OPTIONS
- Call-ID: 7ce9b06349acd7bd-6746@198.27.82.183
- Max-Forwards: 70
- Content-Length: 0
- ------------------------------------------------------------------------
- send 675 bytes to udp/[198.27.82.183]:5060 at 10:50:46.988418:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bKcbdb.e4795e65.0
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-5ba6
- To: <sip:192.99.2.226:11000>;tag=t3y5t6yUj6Dvr
- Call-ID: 7ce9b06349acd7bd-6746@198.27.82.183
- CSeq: 10 OPTIONS
- Contact: <sip:192.99.2.226:11000>
- User-Agent: 2600hz
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 309 bytes from udp/[198.27.82.183]:5060 at 10:50:46.988483:
- ------------------------------------------------------------------------
- OPTIONS sip:192.99.2.226:11000 SIP/2.0
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bKebdb.92f545d7.0
- To: sip:192.99.2.226:11000
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-80cd
- CSeq: 10 OPTIONS
- Call-ID: 7ce9b06349acd7bf-6746@198.27.82.183
- Max-Forwards: 70
- Content-Length: 0
- ------------------------------------------------------------------------
- send 675 bytes to udp/[198.27.82.183]:5060 at 10:50:46.988547:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bKebdb.92f545d7.0
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-80cd
- To: <sip:192.99.2.226:11000>;tag=ZgX13DKD4jXSj
- Call-ID: 7ce9b06349acd7bf-6746@198.27.82.183
- CSeq: 10 OPTIONS
- Contact: <sip:192.99.2.226:11000>
- User-Agent: 2600hz
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Content-Length: 0
- ------------------------------------------------------------------------
- recv 865 bytes from udp/[192.99.2.170]:5060 at 10:50:47.870048:
- ------------------------------------------------------------------------
- BYE sip:104@192.99.2.226:11000;transport=udp SIP/2.0
- Via: SIP/2.0/UDP 192.99.2.170;branch=z9hG4bK0bd6.46dc7722.0;i=2955
- Via: SIP/2.0/TLS 100.38.128.26:38715;branch=z9hG4bK-524287-1---cd9b3250c79a9e7e;rport=38715
- Max-Forwards: 50
- Contact: <sip:davidcell@100.38.128.26:38715;transport=TLS>
- To: <sip:104@revolt.revoltcloud.com;transport=TLS>;tag=vNHQyv02crt1F
- From: "17187637958"<sip:davidcell@revolt.revoltcloud.com;transport=TLS>;tag=5794f71e
- Call-ID: ppF_pmaC4dt1uXp-2_KLbA..
- CSeq: 3 BYE
- Proxy-Authorization: Digest username="davidcell",realm="revolt.revoltcloud.com",nonce="e2b32634-b785-11e4-81f0-135f369896d1",uri="sip:104@192.99.2.226:11000;transport=udp",response="05310f43ee6baabaa341f22d80443449",cnonce="be663866cc85938167e8c93b373a52f6",nc=00000002,qop=auth,algorithm=MD5
- User-Agent: Zoiper r29567
- Content-Length: 0
- X-AUTH-IP: 100.38.128.26
- ------------------------------------------------------------------------
- 2015-02-18 10:50:47.860768 [DEBUG] switch_core_session.c:1052 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:47.860768 [NOTICE] sofia.c:926 Hangup sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [CS_EXECUTE] [NORMAL_CLEARING]
- 2015-02-18 10:50:47.860768 [DEBUG] switch_channel.c:3217 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [KILL]
- 2015-02-18 10:50:47.860768 [DEBUG] switch_core_session.c:1387 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:47.860768 [DEBUG] switch_ivr_play_say.c:1715 done playing file /usr/share/freeswitch/http_cache/e7/395b92-b785-11e4-8210-135f369896d1.wav
- send 559 bytes to udp/[192.99.2.170]:5060 at 10:50:47.879678:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 192.99.2.170;branch=z9hG4bK0bd6.46dc7722.0;i=2955
- Via: SIP/2.0/TLS 100.38.128.26:38715;branch=z9hG4bK-524287-1---cd9b3250c79a9e7e;rport=38715
- From: "17187637958"<sip:davidcell@revolt.revoltcloud.com;transport=TLS>;tag=5794f71e
- To: <sip:104@revolt.revoltcloud.com;transport=TLS>;tag=vNHQyv02crt1F
- Call-ID: ppF_pmaC4dt1uXp-2_KLbA..
- CSeq: 3 BYE
- User-Agent: 2600hz
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: path, replaces
- Content-Length: 0
- ------------------------------------------------------------------------
- 2015-02-18 10:50:47.860768 [DEBUG] switch_core_session.c:2887 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
- 2015-02-18 10:50:47.860768 [DEBUG] switch_ivr.c:657 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com skip receive message [AUDIO_SYNC] (channel is hungup already)
- 2015-02-18 10:50:47.860768 [DEBUG] switch_core_session.c:2887 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com skip receive message [APPLICATION_EXEC_COMPLETE] (channel is hungup already)
- 2015-02-18 10:50:47.860768 [DEBUG] switch_core_state_machine.c:533 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State EXECUTE going to sleep
- 2015-02-18 10:50:47.860768 [DEBUG] switch_core_state_machine.c:470 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) Running State Change CS_HANGUP
- 2015-02-18 10:50:47.860768 [DEBUG] switch_core_state_machine.c:733 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) Callstate Change ACTIVE -> HANGUP
- 2015-02-18 10:50:47.860768 [DEBUG] switch_core_state_machine.c:735 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State HANGUP
- 2015-02-18 10:50:47.860768 [DEBUG] mod_sofia.c:407 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Overriding SIP cause 480 with 415 from the other leg
- 2015-02-18 10:50:47.860768 [DEBUG] mod_sofia.c:413 Channel sofia/sipinterface_1/davidcell@revolt.revoltcloud.com hanging up, cause: NORMAL_CLEARING
- 2015-02-18 10:50:47.880768 [DEBUG] switch_core_state_machine.c:58 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Standard HANGUP, cause: NORMAL_CLEARING
- 2015-02-18 10:50:47.880768 [DEBUG] switch_core_state_machine.c:735 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State HANGUP going to sleep
- 2015-02-18 10:50:47.880768 [DEBUG] switch_core_state_machine.c:502 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State Change CS_HANGUP -> CS_REPORTING
- 2015-02-18 10:50:47.880768 [DEBUG] switch_core_session.c:1387 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:47.880768 [DEBUG] switch_core_state_machine.c:470 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) Running State Change CS_REPORTING
- 2015-02-18 10:50:47.880768 [DEBUG] switch_core_state_machine.c:821 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State REPORTING
- 2015-02-18 10:50:47.880768 [DEBUG] switch_core_state_machine.c:102 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Standard REPORTING, cause: NORMAL_CLEARING
- 2015-02-18 10:50:47.880768 [DEBUG] switch_core_state_machine.c:821 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State REPORTING going to sleep
- 2015-02-18 10:50:47.880768 [DEBUG] switch_core_state_machine.c:496 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State Change CS_REPORTING -> CS_DESTROY
- 2015-02-18 10:50:47.880768 [DEBUG] switch_core_session.c:1387 Send signal sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [BREAK]
- 2015-02-18 10:50:47.880768 [DEBUG] switch_core_session.c:1614 Session 1 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) Locked, Waiting on external entities
- 2015-02-18 10:50:47.880768 [NOTICE] switch_core_session.c:1632 Session 1 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) Ended
- 2015-02-18 10:50:47.880768 [NOTICE] switch_core_session.c:1636 Close Channel sofia/sipinterface_1/davidcell@revolt.revoltcloud.com [CS_DESTROY]
- 2015-02-18 10:50:47.880768 [DEBUG] switch_core_state_machine.c:624 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) Running State Change CS_DESTROY
- 2015-02-18 10:50:47.880768 [DEBUG] switch_core_state_machine.c:634 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State DESTROY
- 2015-02-18 10:50:47.880768 [DEBUG] mod_sofia.c:323 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com SOFIA DESTROY
- 2015-02-18 10:50:47.880768 [DEBUG] switch_core_state_machine.c:109 sofia/sipinterface_1/davidcell@revolt.revoltcloud.com Standard DESTROY
- 2015-02-18 10:50:47.880768 [DEBUG] switch_core_state_machine.c:634 (sofia/sipinterface_1/davidcell@revolt.revoltcloud.com) State DESTROY going to sleep
- 2015-02-18 10:50:47.880768 [NOTICE] kazoo_node.c:285 log|ppF_pmaC4dt1uXp-2_KLbA..|executing event Event-Subclass=whistle::noop,Event-Name=CUSTOM,whistle_event_name=CHANNEL_EXECUTE_COMPLETE,whistle_application_name=noop,whistle_application_response=8af300dc6e0161228f0ef774c6be9d92
- 2015-02-18 10:50:48.080772 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.2086.264>
- 2015-02-18 10:50:48.080772 [INFO] kazoo_node.c:625 exec: uuid_setvar(ppF_pmaC4dt1uXp-2_KLbA.. playback_terminators 123456789*0#)
- span class="re2"> span class="re2"> 2015-02-18 10:50:48.280783 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.2086.264>
- 2015-02-18 10:50:48.280783 [NOTICE] kazoo_node.c:285 log|ppF_pmaC4dt1uXp-2_KLbA..|executing record /tmp/0960f54a2c7099f2d913bfa9e00a3b2d.mp3 500 200 5
- 2015-02-18 10:50:48.480780 [DEBUG] kazoo_node.c:1100 Sent erlang message to ecallmgr@ns5000330.ip-192-99-2.net <3.2086.264>
- recv 309 bytes from udp/[198.27.82.183]:5060 at 10:50:48.988331:
- ------------------------------------------------------------------------
- OPTIONS sip:192.99.2.226:11000 SIP/2.0
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bK2cdb.50b2d4c4.0
- To: sip:192.99.2.226:11000
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-369b
- CSeq: 10 OPTIONS
- Call-ID: 7ce9b06349acd7bb-6746@198.27.82.183
- Max-Forwards: 70
- Content-Length: 0
- ------------------------------------------------------------------------
- send 675 bytes to udp/[198.27.82.183]:5060 at 10:50:48.988429:
- ------------------------------------------------------------------------
- SIP/2.0 200 OK
- Via: SIP/2.0/UDP 198.27.82.183;branch=z9hG4bK2cdb.50b2d4c4.0
- From: sip:sipcheck@198.27.82.183;tag=ff021d86b7c45693467b7c7db964bf77-369b
- To: <sip:192.99.2.226:11000>;tag=rHcmQgXmrm1pH
- Call-ID: 7ce9b06349acd7bb-6746@198.27.82.183
- CSeq: 10 OPTIONS
- Contact: <sip:192.99.2.226:11000>
- User-Agent: 2600hz
- Accept: application/sdp
- Allow: INVITE, ACK, BYE, CANCEL, OPTIONS, MESSAGE, INFO, UPDATE, REGISTER, REFER, NOTIFY, PUBLISH, SUBSCRIBE
- Supported: path, replaces
- Allow-Events: talk, hold, conference, presence, as-feature-event, dialog, line-seize, call-info, sla, include-session-description, presence.winfo, message-summary, refer
- Content-Length: 0
Advertisement
Add Comment
Please, Sign In to add comment
Advertisement