Skip to content

Instantly share code, notes, and snippets.

@tpowell01

tpowell01/transfer-hangup

Created June 14, 2012 22:46
Show Gist options
  • Save tpowell01/2933475 to your computer and use it in GitHub Desktop.
Save tpowell01/2933475 to your computer and use it in GitHub Desktop.
Download ZIP
Transfer Hangs up?
Raw
transfer-hangup
00019 187f 10:44:12 PM Received new TropoML document on Tropo-Thread-354a3da65b5ddcdc6411a4b1b88296b9: {"tropo":[{"transfer":{"to":"8135973730"}}]}
00020 187f 10:44:12 PM Processing document http://97.76.29.90:9292/activation/redirect.json for instance 354a3da65b5ddcdc6411a4b1b88296b9 callFactory for instance 354a3da65b5ddcdc6411a4b1b88296b9
00021 187f 10:44:12 PM SimpleIncomingCall[tim.powell.dev/tim.powell.dev->9996200587/990009369996200587]->transfer([8135973730]) [from:null,timeout:30000,ttsOrUrl:null,grammar:null,termChar:null,repeat:1,answerOnMedia:false,interdigitTimeout:0,allowSignals:*]
00022 187f 10:44:12 PM transferWithoutMedia on answered incoming call.
00023 187f 10:44:12 PM SimpleIncomingCall[tim.powell.dev/tim.powell.dev->9996200587/990009369996200587] : termChar with no grammar. Setting grammar to equal termChar: dtmf-a
00024 187f 10:44:12 PM Starting listener thread Tropo-Thread-354a3da65b5ddcdc6411a4b1b88296b9-MrcpHotWordListener@6cb287c6
00025 187f 10:44:12 PM >>call([8135973730], tim.powell.dev, VOICE, SKYPE, null, false, 30000, null, null, null, {}, [])
00026 187f 10:44:12 PM >>call(null, tim.powell.dev, tel:+18135973730, false, {})
00027 187f 10:44:12 PM _inst.sessionId = 354a3da65b5ddcdc6411a4b1b88296b9
00028 187f 10:44:12 PM tgInst.sessionId = 354a3da65b5ddcdc6411a4b1b88296b9
00029 187f 10:44:12 PM Parse result for [tel:+18135973730] : CalledNumber@34a4eae7[to=tel:+18135973730 pause=0 postDial=null]
00030 187f 10:44:12 PM Creating outgoing call : sip:tim.powell.dev@sip.tropo.com-->sip:+18135973730@sbc-internal.tropo.com,false
00031 187f 10:44:12 PM From: sip:tim.powell.dev@sip.tropo.com/tim.powell.dev
00032 187f 10:44:12 PM To: sip:+18135973730@sbc-internal.tropo.com/tel:+18135973730
00033 187f 10:44:12 PM Attribute TransferPeerSession added to Sip Session ss_ckhzath8n62h in state INITIAL
00034 187f 10:44:12 PM Attribute TransferPeerSession added to Sip Session ss_w78z6p09voux in state CONFIRMED
00035 187f 10:44:12 PM Creating SimpleOutgoingCall from original request [INVITE sip:+18135973730@sbc-internal.tropo.com SIP/2.0 To: sip:+18135973730@sbc-internal.tropo.com x-sid: 354a3da65b5ddcdc6411a4b1b88296b9 CSeq: 1 INVITE Content-Length: 0 x-accountid: 139446 Call-ID: 138ylks8zp7qv From: <sip:tim.powell.dev@sip.tropo.com>;tag=1939q8dtvr0l2 x-appid: 350420 ] using new request [INVITE sip:+18135973730@sbc-internal.tropo.com SIP/2.0 To: sip:+18135973730@sbc-internal.tropo.com x-sid: 354a3da65b5ddcdc6411a4b1b88296b9 CSeq: 1 INVITE Content-Length: 0 x-accountid: 139446 Call-ID: 138ylks8zp7qv From: <sip:tim.powell.dev@sip.tropo.com>;tag=1939q8dtvr0l2 x-appid: 350420 ]
00036 187f 10:44:12 PM Set logging context for Tropo-Thread-354a3da65b5ddcdc6411a4b1b88296b9-MrcpHotWordListener@6cb287c6 to accountID=139446 host=null sessionGUID=ca5cb302cbe82163c652abf7349e187f sessionNumber=354a3da65b5ddcdc6411a4b1b88296b9 callID=68cc30924cefdb622e25ae3bbe7fce3a
00037 187f 10:44:12 PM Attribute com.voxeo.tropo.core.call.inst added to Sip Session ss_ckhzath8n62h in state INITIAL
00038 187f 10:44:12 PM SipSession ss_ckhzath8n62h - 138ylks8zp7qv associated with Tropo call a4fc71663364d6c69d9ee26b02514336
00039 187f 10:44:12 PM This is a direct call, will not initialize MrcpClient
00040 187f 10:44:12 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] state is changed: NEW->ANSWERING
00041 187f 10:44:12 PM Call a4fc71663364d6c69d9ee26b02514336 state changed from NEW to ANSWERING on thread Tropo-Thread-354a3da65b5ddcdc6411a4b1b88296b9
00042 187f 10:44:12 PM to uri is sip:+18135973730@sbc-internal.tropo.com
00043 187f 10:44:12 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] will be called.
00044 187f 10:44:12 PM Set logging context for Tropo-Thread-354a3da65b5ddcdc6411a4b1b88296b9 to accountID=139446 host=null sessionGUID=ca5cb302cbe82163c652abf7349e187f sessionNumber=354a3da65b5ddcdc6411a4b1b88296b9 callID=a4fc71663364d6c69d9ee26b02514336
00045 187f 10:44:12 PM Registering call tim.powell.dev -> +18135973730
00046 187f 10:44:12 PM getFirstCall() spawning MakeCall in thread Thread-5252 in group Tropo-ThreadGroup-sas_2-14-smkngey8md8tintropo
00047 187f 10:44:12 PM Set logging context for Thread-5252 to accountID=139446 host=null sessionGUID=ca5cb302cbe82163c652abf7349e187f sessionNumber=354a3da65b5ddcdc6411a4b1b88296b9 callID=a4fc71663364d6c69d9ee26b02514336
00048 187f 10:44:12 PM Calling tim.powell.dev -> +18135973730
00049 187f 10:44:12 PM >>[tim.powell.dev/null to +18135973730/null] ring(30000, null, null, null)
00050 187f 10:44:12 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] is calling.
00051 187f 10:44:12 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null]->sending outgoing INVITE [timeout:30000,answerOnMedia:false]: [INVITE sip:+18135973730@sbc-internal.tropo.com SIP/2.0 To: sip:+18135973730@sbc-internal.tropo.com Via: SIP/2.0/UDP 10.6.69.203:5060;branch=z9hG4bKamqf8ktd6719;rport x-sid: 354a3da65b5ddcdc6411a4b1b88296b9 CSeq: 1 INVITE Content-Length: 0 x-accountid: 139446 Call-ID: 138ylks8zp7qv Max-Forwards: 70 From: <sip:tim.powell.dev@sip.tropo.com>;tag=1939q8dtvr0l2 Contact: <sip:10.6.69.203:5060;transport=udp> x-appid: 350420 ]
00052 187f 10:44:12 PM Starting listener thread Thread-5252-MrcpRTCListener@686f591b
00053 187f 10:44:12 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] : Calling await(30000) on Thread-5252
00054 187f 10:44:12 PM Set logging context for Thread-5252-MrcpRTCListener@686f591b to accountID=139446 host=null sessionGUID=ca5cb302cbe82163c652abf7349e187f sessionNumber=354a3da65b5ddcdc6411a4b1b88296b9 callID=a4fc71663364d6c69d9ee26b02514336
00055 187f 10:44:12 PM Set logging context for udp/0.0.0.0/5060-t-4 to accountID=139446 host=null sessionGUID=ca5cb302cbe82163c652abf7349e187f sessionNumber=354a3da65b5ddcdc6411a4b1b88296b9 callID=a4fc71663364d6c69d9ee26b02514336
00056 187f 10:44:12 PM do180INVITE find call: SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null]
00057 187f 10:44:12 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] state is changed: ANSWERING->RINGING
00058 187f 10:44:12 PM Call a4fc71663364d6c69d9ee26b02514336 state changed from ANSWERING to RINGING on thread udp/0.0.0.0/5060-t-4
00059 187f 10:44:12 PM Clearing logging context for udp/0.0.0.0/5060-t-4
00060 187f 10:44:13 PM Set logging context for udp/0.0.0.0/5060-t-4 to accountID=139446 host=null sessionGUID=ca5cb302cbe82163c652abf7349e187f sessionNumber=354a3da65b5ddcdc6411a4b1b88296b9 callID=a4fc71663364d6c69d9ee26b02514336
00061 187f 10:44:13 PM do404INVITE find call: SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null]
00062 187f 10:44:13 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] state is changed: RINGING->DISCONNECTED
00063 187f 10:44:13 PM Call a4fc71663364d6c69d9ee26b02514336 state changed from RINGING to DISCONNECTED on thread udp/0.0.0.0/5060-t-4
00064 187f 10:44:13 PM Stopping listener
00065 187f 10:44:13 PM Stopping listener thread Thread-5252-MrcpRTCListener@686f591b
00066 187f 10:44:13 PM Notifying waiting threads
00067 187f 10:44:13 PM Stopping MRCP
00068 187f 10:44:13 PM MRCP stopped
00069 187f 10:44:13 PM Disconnect processed
00070 187f 10:44:13 PM Clearing logging context for udp/0.0.0.0/5060-t-4
00071 187f 10:44:13 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] : Done awaiting on Thread-5252
00072 187f 10:44:13 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] : await() returning null
00073 187f 10:44:13 PM listener is com.voxeo.tropo.util.MrcpRTCListener@686f591b, listener's event is null, and listener's url is null
00074 187f 10:44:13 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] can not be completed at this time.
00075 187f 10:44:13 PM Call from tim.powell.dev to +18135973730 failed. com.voxeo.tropo.ErrorException: Outbound call can not complete. at com.voxeo.tropo.core.SimpleOutgoingCall.ring(SimpleOutgoingCall.java:175) at sun.reflect.GeneratedMethodAccessor178.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) at java.lang.reflect.Method.invoke(Unknown Source) at com.voxeo.tropo.sandbox.SandboxInvocationHandler.invoke(SandboxInvocationHandler.java:42) at $Proxy60.ring(Unknown Source) at com.voxeo.tropo.core.MultiCallCoordinator$MakeCall.run(MultiCallCoordinator.java:154)
00076 187f 10:44:13 PM Listener com.voxeo.tropo.util.MrcpRTCListener@686f591b received result: null
00077 187f 10:44:13 PM Unregistering call tim.powell.dev -> +18135973730
00078 187f 10:44:13 PM Transfer without media failed when calling transferee.com.voxeo.tropo.ErrorException: Outbound call can not complete.
00079 187f 10:44:13 PM Attribute TransferPeerSession removed from Sip Session ss_w78z6p09voux in state CONFIRMED
00080 187f 10:44:13 PM Stopping listener thread Tropo-Thread-354a3da65b5ddcdc6411a4b1b88296b9-MrcpHotWordListener@6cb287c6
00081 187f 10:44:13 PM Hanging up on call from tim.powell.dev to +18135973730 failed.
00082 187f 10:44:13 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null]->hangup(), _state=DISCONNECTED
00083 187f 10:44:13 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null]->disconnect(), headers={}
00084 187f 10:44:13 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null] state is changed: DISCONNECTED->DISCONNECTED
00085 187f 10:44:13 PM SimpleOutgoingCall[tim.powell.dev/null->+18135973730/null]<-hangup(), _state=DISCONNECTED
00086 187f 10:44:13 PM Failed to transfer call com.voxeo.tropo.ErrorException: Outbound call can not complete. at com.voxeo.tropo.core.SimpleOutgoingCall.ring(SimpleOutgoingCall.java:175) at sun.reflect.GeneratedMethodAccessor178.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) at java.lang.reflect.Method.invoke(Unknown Source) at com.voxeo.tropo.sandbox.SandboxInvocationHandler.invoke(SandboxInvocationHandler.java:42) at $Proxy60.ring(Unknown Source) at com.voxeo.tropo.core.MultiCallCoordinator$MakeCall.run(MultiCallCoordinator.java:154)
00087 187f 10:44:13 PM Interrupting call()
00088 187f 10:44:13 PM Processing events: incomplete
00089 187f 10:44:13 PM Processing events: continue
00090 187f 10:44:13 PM SimpleIncomingCall[tim.powell.dev/tim.powell.dev->9996200587/990009369996200587]->hangup(), _state=ANSWERED
00091 187f 10:44:13 PM SimpleIncomingCall[tim.powell.dev/tim.powell.dev->9996200587/990009369996200587]->disconnect(), headers={}
00092 187f 10:44:13 PM SimpleIncomingCall[tim.powell.dev/tim.powell.dev->9996200587/990009369996200587] state is changed: ANSWERED->DISCONNECTED
00093 187f 10:44:13 PM Call 68cc30924cefdb622e25ae3bbe7fce3a state changed from ANSWERED to DISCONNECTED on thread Tropo-Thread-354a3da65b5ddcdc6411a4b1b88296b9
00094 187f 10:44:13 PM Stopping MRCP
00095 187f 10:44:13 PM Stopping TTS
00096 187f 10:44:13 PM TTS stopped
00097 187f 10:44:13 PM Stopping ASR
00098 187f 10:44:13 PM ASR stopped
00099 187f 10:44:13 PM MRCP stopped
00100 187f 10:44:13 PM Logging CDR {"call":{"SipSessionID":"ss_w78z6p09voux","SessionID":"354a3da65b5ddcdc6411a4b1b88296b9","CallID":"68cc30924cefdb622e25ae3bbe7fce3a","ParentSessionID":"none","ParentCallID":"none","DateCreated":"Thu, 14 Jun 2012 22:43:52 +0000","DateUpdated":"Thu, 14 Jun 2012 22:43:52 +0000","AccountID":"139446","Called":"9996200587","Caller":"tim.powell.dev","PhoneNumberSid":"unknown","Disposition":"Success","Status":"Success","StartTime":"Thu, 14 Jun 2012 22:43:52 +0000","EndTime":"Thu, 14 Jun 2012 22:44:13 +0000","Duration":"20983","Flags":"in","RecordingDuration":"0","Network":"SKYPE","Channel":"VOICE","ApplicationId":"350420","ApplicationType":"tropo-web","ServiceId":"1182607","StartUrl":"http://97.76.29.90:9292/activation/start.json","BrowserIP":"10.6.69.203","PPID":"410"}}
00101 187f 10:44:13 PM Submitting CDR [callId=68cc30924cefdb622e25ae3bbe7fce3a, text={"call":{"SipSessionID":"ss_w78z6p09voux","SessionID":"354a3da65b5ddcdc6411a4b1b88296b9","CallID":"68cc30924cefdb622e25ae3bbe7fce3a","ParentSessionID":"none","ParentCallID":"none","DateCreated":"Thu, 14 Jun 2012 22:43:52 +0000","DateUpdated":"Thu, 14 Jun 2012 22:43:52 +0000","AccountID":"139446","Called":"9996200587","Caller":"tim.powell.dev","PhoneNumberSid":"unknown","Disposition":"Success","Status":"Success","StartTime":"Thu, 14 Jun 2012 22:43:52 +0000","EndTime":"Thu, 14 Jun 2012 22:44:13 +0000","Duration":"20983","Flags":"in","RecordingDuration":"0","Network":"SKYPE","Channel":"VOICE","ApplicationId":"350420","ApplicationType":"tropo-web","ServiceId":"1182607","StartUrl":"http://97.76.29.90:9292/activation/start.json","BrowserIP":"10.6.69.203","PPID":"410"}}]
00102 187f 10:44:13 PM Disconnect processed
00103 187f 10:44:13 PM SimpleIncomingCall[tim.powell.dev/tim.powell.dev->9996200587/990009369996200587]<-hangup(), _state=DISCONNECTED
00104 187f 10:44:13 PM Processing events: hangup
00105 187f 10:44:13 PM Thread Tropo-Thread-354a3da65b5ddcdc6411a4b1b88296b9 returned engine com.tropo.rest.engine.TropoScriptEngine@1638e0fd of type tropo-web, activeEngines = 6
00106 187f 10:44:13 PM ApplicationInstance[http://97.76.29.90:9292/activation/start.json , sas_2-14-smkngey8md8tintropo] ends execution on Thread Tropo-Thread-354a3da65b5ddcdc6411a4b1b88296b9
00107 187f 10:44:13 PM sas_2-14-smkngey8md8tintropo will invalidate when ready
00108 187f 10:44:13 PM Account 139446 has 0 sessions
00109 187f 10:44:13 PM Instance 354a3da65b5ddcdc6411a4b1b88296b9 removed
00110 187f 10:44:13 PM Clearing logging context for Tropo-Thread-354a3da65b5ddcdc6411a4b1b88296b9
00111 187f 10:44:13 PM Sent CDR [callId=68cc30924cefdb622e25ae3bbe7fce3a]
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment